builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1451483064.63 results: success (0) buildid: 20151230030234 builduid: 84e604e7cd624a93b3beb7f9fa2f8eee revision: c690c50b2b543b420803e8192d6e08e06b20e0a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.629509) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.629907) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.630209) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.657975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.658281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.677318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.677644) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.726758) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.727070) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.727449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.727719) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 05:44:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.5M=0s 2015-12-30 05:44:25 (64.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160574 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.900587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.900900) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015170 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:24.952112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-30 05:44:24.952475) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c690c50b2b543b420803e8192d6e08e06b20e0a3 --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 c690c50b2b543b420803e8192d6e08e06b20e0a3 --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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 05:44:25,876 truncating revision to first 12 chars 2015-12-30 05:44:25,876 Setting DEBUG logging. 2015-12-30 05:44:25,876 attempt 1/10 2015-12-30 05:44:25,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c690c50b2b54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 05:44:26,640 unpacking tar archive at: mozilla-central-c690c50b2b54/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-30 05:44:25.999194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:25.999497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:26.007129) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:26.007518) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 05:44:26.007959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 05:44:26.008279) ========= /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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:27 INFO - MultiFileLogger online at 20151230 05:44:27 in /builds/slave/test-pgo 05:44:27 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 05:44:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:44:27 INFO - {'append_to_log': False, 05:44:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:44:27 INFO - 'blob_upload_branch': 'Firefox', 05:44:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:44:27 INFO - 'branch': 'Firefox', 05:44:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:27 INFO - 'config_files': ('talos/linux_config.py',), 05:44:27 INFO - 'default_actions': ('clobber', 05:44:27 INFO - 'read-buildbot-config', 05:44:27 INFO - 'download-and-extract', 05:44:27 INFO - 'populate-webroot', 05:44:27 INFO - 'create-virtualenv', 05:44:27 INFO - 'install', 05:44:27 INFO - 'run-tests'), 05:44:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:27 INFO - 'download_minidump_stackwalk': True, 05:44:27 INFO - 'download_symbols': 'ondemand', 05:44:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:27 INFO - 'installer_path': 'installer.exe', 05:44:27 INFO - 'log_level': 'info', 05:44:27 INFO - 'log_name': 'talos', 05:44:27 INFO - 'log_to_console': True, 05:44:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:27 INFO - 'opt_config_files': (), 05:44:27 INFO - 'pip_index': False, 05:44:27 INFO - 'sps_profile': False, 05:44:27 INFO - 'sps_profile_interval': 0, 05:44:27 INFO - 'suite': 'dromaeojs', 05:44:27 INFO - 'system_bits': '32', 05:44:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:27 INFO - 'title': 'talos-linux64-ix-045', 05:44:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:27 INFO - 'use_talos_json': True, 05:44:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:44:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:27 INFO - 'work_dir': 'build'} 05:44:27 INFO - ##### 05:44:27 INFO - ##### Running clobber step. 05:44:27 INFO - ##### 05:44:27 INFO - Running pre-action listener: _resource_record_pre_action 05:44:27 INFO - Running main action method: clobber 05:44:27 INFO - rmtree: /builds/slave/test-pgo/build 05:44:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:44:27 INFO - Running post-action listener: _resource_record_post_action 05:44:27 INFO - ##### 05:44:27 INFO - ##### Running read-buildbot-config step. 05:44:27 INFO - ##### 05:44:27 INFO - Running pre-action listener: _resource_record_pre_action 05:44:27 INFO - Running main action method: read_buildbot_config 05:44:27 INFO - Using buildbot properties: 05:44:27 INFO - { 05:44:27 INFO - "project": "", 05:44:27 INFO - "product": "firefox", 05:44:27 INFO - "script_repo_revision": "production", 05:44:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:44:27 INFO - "repository": "", 05:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:44:27 INFO - "buildid": "20151230030234", 05:44:27 INFO - "stage_platform": "linux64-pgo", 05:44:27 INFO - "basedir": "/builds/slave/test-pgo", 05:44:27 INFO - "nightly_build": "True", 05:44:27 INFO - "buildnumber": 622, 05:44:27 INFO - "slavename": "talos-linux64-ix-045", 05:44:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:27 INFO - "platform": "ubuntu64_hw", 05:44:27 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:27 INFO - "branch": "mozilla-central", 05:44:27 INFO - "repo_path": "mozilla-central", 05:44:27 INFO - "revision": "c690c50b2b543b420803e8192d6e08e06b20e0a3", 05:44:27 INFO - "pgo_build": "True", 05:44:27 INFO - "builduid": "84e604e7cd624a93b3beb7f9fa2f8eee", 05:44:27 INFO - "slavebuilddir": "test" 05:44:27 INFO - } 05:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:44:27 INFO - Running post-action listener: _resource_record_post_action 05:44:27 INFO - ##### 05:44:27 INFO - ##### Running download-and-extract step. 05:44:27 INFO - ##### 05:44:27 INFO - Running pre-action listener: _resource_record_pre_action 05:44:27 INFO - Running main action method: download_and_extract 05:44:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:44: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')]} 05:44:27 INFO - https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/test_packages.json 05:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/test_packages.json 05:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:44:34 INFO - Downloaded 1302 bytes. 05:44:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:44:34 INFO - Using the following test package requirements: 05:44:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'jsshell-linux-x86_64.zip'], 05:44:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:34 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')]} 05:44:34 INFO - https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:37 INFO - Downloaded 23202566 bytes. 05:44:37 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 05:44:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:37 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 05:44:38 INFO - Return code: 0 05:44:38 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 05:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:38 INFO - https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:42 INFO - Downloaded 23202566 bytes. 05:44:42 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 05:44:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:42 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 05:44:43 INFO - Return code: 0 05:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:43 INFO - https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:46 INFO - Downloaded 11132285 bytes. 05:44:46 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 05:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:46 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 05:44:46 INFO - Return code: 0 05:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:46 INFO - https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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 05:44:47 INFO - Downloaded 54946225 bytes. 05:44:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:47 INFO - mkdir: /builds/slave/test-pgo/properties 05:44:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:44:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:44:47 INFO - Contents: 05:44:47 INFO - build_url:https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:47 INFO - Running post-action listener: _resource_record_post_action 05:44:47 INFO - Running post-action listener: set_extra_try_arguments 05:44:47 INFO - ##### 05:44:47 INFO - ##### Running populate-webroot step. 05:44:47 INFO - ##### 05:44:47 INFO - Running pre-action listener: _resource_record_pre_action 05:44:47 INFO - Running main action method: populate_webroot 05:44:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:47 INFO - '--tppagecycles', 05:44:47 INFO - '7'], 05:44:47 INFO - 'tests': ['tsvgm']}}, 05:44:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:44:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'tests': ['damp', 'tps']}, 05:44:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['damp', 'tps']}, 05:44:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:44:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:47 INFO - 'other': {'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'other_l64': {'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:44:47 INFO - 'ts_paint', 05:44:47 INFO - 'tpaint', 05:44:47 INFO - 'sessionrestore', 05:44:47 INFO - 'sessionrestore_no_auto_restore']}, 05:44:47 INFO - 'svgr': {'tests': ['tsvgx', 05:44:47 INFO - 'tsvgr_opacity', 05:44:47 INFO - 'tart', 05:44:47 INFO - 'tscrollx', 05:44:47 INFO - 'cart']}, 05:44:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['tsvgx', 05:44:47 INFO - 'tsvgr_opacity', 05:44:47 INFO - 'tart', 05:44:47 INFO - 'tscrollx', 05:44:47 INFO - 'cart']}, 05:44:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'tests': ['tp5o']}, 05:44:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'talos_options': ['--e10s'], 05:44:47 INFO - 'tests': ['tp5o']}, 05:44:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'talos_options': ['--xperf_path', 05:44:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:47 INFO - 'tests': ['tp5n']}, 05:44:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:47 INFO - 'talos_options': ['--e10s', 05:44:47 INFO - '--xperf_path', 05:44:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:47 INFO - 'tests': ['tp5n']}}, 05:44:47 INFO - 'talos.zip': {'path': '', 05:44:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:47 INFO - Running post-action listener: _resource_record_post_action 05:44:47 INFO - ##### 05:44:47 INFO - ##### Running create-virtualenv step. 05:44:47 INFO - ##### 05:44:47 INFO - Running pre-action listener: _resource_record_pre_action 05:44:47 INFO - Running main action method: create_virtualenv 05:44:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:44:47 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 05:44:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:44:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:47 INFO - Using real prefix '/usr' 05:44:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:44:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:50 INFO - Installing pip.................done. 05:44:50 INFO - Return code: 0 05:44:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:44:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:44:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:44:50 INFO - Using env: {'DISPLAY': ':0', 05:44:50 INFO - 'HOME': '/home/cltbld', 05:44:50 INFO - 'LANG': 'en_US.UTF-8', 05:44:50 INFO - 'LANGUAGE': 'en_US:en', 05:44:50 INFO - 'LOGNAME': 'cltbld', 05:44:50 INFO - 'MAIL': '/var/mail/cltbld', 05:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:50 INFO - 'MOZ_NO_REMOTE': '1', 05:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:50 INFO - 'NO_EM_RESTART': '1', 05:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:50 INFO - 'SHELL': '/bin/bash', 05:44:50 INFO - 'SHLVL': '1', 05:44:50 INFO - 'TERM': 'linux', 05:44:50 INFO - 'TMOUT': '86400', 05:44:50 INFO - 'USER': 'cltbld', 05:44:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:50 INFO - '_': '/tools/buildbot/bin/python'} 05:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:50 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 05:44:50 INFO - Cleaning up... 05:44:50 INFO - Return code: 0 05:44:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:44:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:44:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:44:50 INFO - Using env: {'DISPLAY': ':0', 05:44:50 INFO - 'HOME': '/home/cltbld', 05:44:50 INFO - 'LANG': 'en_US.UTF-8', 05:44:50 INFO - 'LANGUAGE': 'en_US:en', 05:44:50 INFO - 'LOGNAME': 'cltbld', 05:44:50 INFO - 'MAIL': '/var/mail/cltbld', 05:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:50 INFO - 'MOZ_NO_REMOTE': '1', 05:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:50 INFO - 'NO_EM_RESTART': '1', 05:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:50 INFO - 'SHELL': '/bin/bash', 05:44:50 INFO - 'SHLVL': '1', 05:44:50 INFO - 'TERM': 'linux', 05:44:50 INFO - 'TMOUT': '86400', 05:44:50 INFO - 'USER': 'cltbld', 05:44:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:50 INFO - '_': '/tools/buildbot/bin/python'} 05:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:50 INFO - Downloading/unpacking psutil>=0.7.1 05:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:44:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:44:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:52 INFO - Installing collected packages: psutil 05:44:52 INFO - Running setup.py install for psutil 05:44:52 INFO - building 'psutil._psutil_linux' extension 05:44:52 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 05:44:52 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 05:44:52 INFO - building 'psutil._psutil_posix' extension 05:44:52 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 05:44:52 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 05:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:53 INFO - Successfully installed psutil 05:44:53 INFO - Cleaning up... 05:44:53 INFO - Return code: 0 05:44:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:44:53 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')]} 05:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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')]} 05:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:53 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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:44:53 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 05:44:53 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 05:44:53 INFO - Using env: {'DISPLAY': ':0', 05:44:53 INFO - 'HOME': '/home/cltbld', 05:44:53 INFO - 'LANG': 'en_US.UTF-8', 05:44:53 INFO - 'LANGUAGE': 'en_US:en', 05:44:53 INFO - 'LOGNAME': 'cltbld', 05:44:53 INFO - 'MAIL': '/var/mail/cltbld', 05:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:53 INFO - 'MOZ_NO_REMOTE': '1', 05:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:53 INFO - 'NO_EM_RESTART': '1', 05:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:53 INFO - 'SHELL': '/bin/bash', 05:44:53 INFO - 'SHLVL': '1', 05:44:53 INFO - 'TERM': 'linux', 05:44:53 INFO - 'TMOUT': '86400', 05:44:53 INFO - 'USER': 'cltbld', 05:44:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:53 INFO - '_': '/tools/buildbot/bin/python'} 05:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:44:53 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 05:44:53 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 05:44:53 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 05:44:53 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 05:44:53 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 05:44:53 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 05:44:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:44:55 INFO - Installing collected packages: mozsystemmonitor 05:44:55 INFO - Running setup.py install for mozsystemmonitor 05:44:55 INFO - Successfully installed mozsystemmonitor 05:44:55 INFO - Cleaning up... 05:44:55 INFO - Return code: 0 05:44:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:44: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')]} 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:44:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:44:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:44:55 INFO - Using env: {'DISPLAY': ':0', 05:44:55 INFO - 'HOME': '/home/cltbld', 05:44:55 INFO - 'LANG': 'en_US.UTF-8', 05:44:55 INFO - 'LANGUAGE': 'en_US:en', 05:44:55 INFO - 'LOGNAME': 'cltbld', 05:44:55 INFO - 'MAIL': '/var/mail/cltbld', 05:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:55 INFO - 'MOZ_NO_REMOTE': '1', 05:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:55 INFO - 'NO_EM_RESTART': '1', 05:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:55 INFO - 'SHELL': '/bin/bash', 05:44:55 INFO - 'SHLVL': '1', 05:44:55 INFO - 'TERM': 'linux', 05:44:55 INFO - 'TMOUT': '86400', 05:44:55 INFO - 'USER': 'cltbld', 05:44:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:55 INFO - '_': '/tools/buildbot/bin/python'} 05:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:44:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:57 INFO - Downloading docopt-0.6.1.tar.gz 05:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:57 INFO - Running setup.py install for blobuploader 05:44:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:44:57 INFO - Running setup.py install for requests 05:44:58 INFO - Running setup.py install for docopt 05:44:58 INFO - Successfully installed blobuploader requests docopt 05:44:58 INFO - Cleaning up... 05:44:58 INFO - Return code: 0 05:44:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:58 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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:44:58 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 05:44:58 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 05:44:58 INFO - Using env: {'DISPLAY': ':0', 05:44:58 INFO - 'HOME': '/home/cltbld', 05:44:58 INFO - 'LANG': 'en_US.UTF-8', 05:44:58 INFO - 'LANGUAGE': 'en_US:en', 05:44:58 INFO - 'LOGNAME': 'cltbld', 05:44:58 INFO - 'MAIL': '/var/mail/cltbld', 05:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:58 INFO - 'MOZ_NO_REMOTE': '1', 05:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:58 INFO - 'NO_EM_RESTART': '1', 05:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:58 INFO - 'SHELL': '/bin/bash', 05:44:58 INFO - 'SHLVL': '1', 05:44:58 INFO - 'TERM': 'linux', 05:44:58 INFO - 'TMOUT': '86400', 05:44:58 INFO - 'USER': 'cltbld', 05:44:58 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:58 INFO - '_': '/tools/buildbot/bin/python'} 05:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:58 INFO - Running setup.py (path:/tmp/pip-G7cq8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:58 INFO - Running setup.py (path:/tmp/pip-9A5YYq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:58 INFO - Running setup.py (path:/tmp/pip-uax4hs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:58 INFO - Running setup.py (path:/tmp/pip-_iYSu7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:58 INFO - Running setup.py (path:/tmp/pip-ngzg1A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:59 INFO - Running setup.py (path:/tmp/pip-EJVPF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:59 INFO - Running setup.py (path:/tmp/pip-miYlKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:59 INFO - Running setup.py (path:/tmp/pip-drrxCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:59 INFO - Running setup.py (path:/tmp/pip-g2Bhbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:59 INFO - Running setup.py (path:/tmp/pip-tSqhxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:59 INFO - Running setup.py (path:/tmp/pip-dIj5tq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:59 INFO - Running setup.py (path:/tmp/pip-iFfoJ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:59 INFO - Running setup.py (path:/tmp/pip-XdRRHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:59 INFO - Running setup.py (path:/tmp/pip-XPrtPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:59 INFO - Running setup.py (path:/tmp/pip-aIxiAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:59 INFO - Running setup.py (path:/tmp/pip-R6ou2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:59 INFO - Running setup.py (path:/tmp/pip-6fI0pn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:44:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:59 INFO - Running setup.py install for manifestparser 05:45:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for mozcrash 05:45:00 INFO - Running setup.py install for mozdebug 05:45:00 INFO - Running setup.py install for mozdevice 05:45:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for mozfile 05:45:00 INFO - Running setup.py install for mozhttpd 05:45:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for mozinfo 05:45:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for mozInstall 05:45:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for mozleak 05:45:00 INFO - Running setup.py install for mozlog 05:45:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:00 INFO - Running setup.py install for moznetwork 05:45:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Running setup.py install for mozprocess 05:45:01 INFO - Running setup.py install for mozprofile 05:45:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Running setup.py install for mozrunner 05:45:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Running setup.py install for mozscreenshot 05:45:01 INFO - Running setup.py install for moztest 05:45:01 INFO - Running setup.py install for mozversion 05:45:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:01 INFO - Cleaning up... 05:45:01 INFO - Return code: 0 05:45:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:45:01 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 05:45:01 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 05:45:01 INFO - Using env: {'DISPLAY': ':0', 05:45:01 INFO - 'HOME': '/home/cltbld', 05:45:01 INFO - 'LANG': 'en_US.UTF-8', 05:45:01 INFO - 'LANGUAGE': 'en_US:en', 05:45:01 INFO - 'LOGNAME': 'cltbld', 05:45:01 INFO - 'MAIL': '/var/mail/cltbld', 05:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:01 INFO - 'MOZ_NO_REMOTE': '1', 05:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:01 INFO - 'NO_EM_RESTART': '1', 05:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:01 INFO - 'SHELL': '/bin/bash', 05:45:01 INFO - 'SHLVL': '1', 05:45:01 INFO - 'TERM': 'linux', 05:45:01 INFO - 'TMOUT': '86400', 05:45:01 INFO - 'USER': 'cltbld', 05:45:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:01 INFO - '_': '/tools/buildbot/bin/python'} 05:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:01 INFO - Running setup.py (path:/tmp/pip-ADAk0J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:02 INFO - Running setup.py (path:/tmp/pip-BAuB4J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:02 INFO - Running setup.py (path:/tmp/pip-veAdJA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:02 INFO - Running setup.py (path:/tmp/pip-ccNedM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:02 INFO - Running setup.py (path:/tmp/pip-Z2VPrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:02 INFO - Running setup.py (path:/tmp/pip-nHbpUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:02 INFO - Running setup.py (path:/tmp/pip-RMIwnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:02 INFO - Running setup.py (path:/tmp/pip-nRU7ZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:02 INFO - Running setup.py (path:/tmp/pip-esVaQD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:02 INFO - Running setup.py (path:/tmp/pip-dPTpKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:02 INFO - Running setup.py (path:/tmp/pip-pEM2n4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:02 INFO - Running setup.py (path:/tmp/pip-cpjgzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:02 INFO - Running setup.py (path:/tmp/pip-n2YQ9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:02 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)) 05:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:02 INFO - Running setup.py (path:/tmp/pip-1ZH2VY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:03 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)) 05:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:03 INFO - Running setup.py (path:/tmp/pip-sOsDsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:03 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)) 05:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:03 INFO - Running setup.py (path:/tmp/pip-uxnxf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:03 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)) 05:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:03 INFO - Running setup.py (path:/tmp/pip-7dyPrf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:03 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)) 05:45:03 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)) 05:45:03 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)) 05:45:03 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)) 05:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:05 INFO - Downloading blessings-1.5.1.tar.gz 05:45:05 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 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:05 INFO - Installing collected packages: blessings 05:45:05 INFO - Running setup.py install for blessings 05:45:05 INFO - Successfully installed blessings 05:45:05 INFO - Cleaning up... 05:45:05 INFO - Return code: 0 05:45:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:05 INFO - Reading from file tmpfile_stdout 05:45:05 INFO - Current package versions: 05:45:05 INFO - argparse == 1.2.1 05:45:05 INFO - blessings == 1.5.1 05:45:05 INFO - blobuploader == 1.2.4 05:45:05 INFO - docopt == 0.6.1 05:45:05 INFO - manifestparser == 1.1 05:45:05 INFO - mozInstall == 1.12 05:45:05 INFO - mozcrash == 0.16 05:45:05 INFO - mozdebug == 0.1 05:45:05 INFO - mozdevice == 0.47 05:45:05 INFO - mozfile == 1.2 05:45:05 INFO - mozhttpd == 0.7 05:45:05 INFO - mozinfo == 0.9 05:45:05 INFO - mozleak == 0.1 05:45:05 INFO - mozlog == 3.1 05:45:05 INFO - moznetwork == 0.27 05:45:05 INFO - mozprocess == 0.22 05:45:05 INFO - mozprofile == 0.28 05:45:05 INFO - mozrunner == 6.11 05:45:05 INFO - mozscreenshot == 0.1 05:45:05 INFO - mozsystemmonitor == 0.0 05:45:05 INFO - moztest == 0.7 05:45:05 INFO - mozversion == 1.4 05:45:05 INFO - psutil == 3.1.1 05:45:05 INFO - requests == 1.2.3 05:45:05 INFO - wsgiref == 0.1.2 05:45:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 05:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 05:45:05 INFO - Using env: {'DISPLAY': ':0', 05:45:05 INFO - 'HOME': '/home/cltbld', 05:45:05 INFO - 'LANG': 'en_US.UTF-8', 05:45:05 INFO - 'LANGUAGE': 'en_US:en', 05:45:05 INFO - 'LOGNAME': 'cltbld', 05:45:05 INFO - 'MAIL': '/var/mail/cltbld', 05:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:05 INFO - 'MOZ_NO_REMOTE': '1', 05:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:05 INFO - 'NO_EM_RESTART': '1', 05:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:05 INFO - 'SHELL': '/bin/bash', 05:45:05 INFO - 'SHLVL': '1', 05:45:05 INFO - 'TERM': 'linux', 05:45:05 INFO - 'TMOUT': '86400', 05:45:05 INFO - 'USER': 'cltbld', 05:45:05 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:05 INFO - '_': '/tools/buildbot/bin/python'} 05:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 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)) 05:45:05 INFO - Cleaning up... 05:45:05 INFO - Return code: 0 05:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:05 INFO - Using env: {'DISPLAY': ':0', 05:45:05 INFO - 'HOME': '/home/cltbld', 05:45:05 INFO - 'LANG': 'en_US.UTF-8', 05:45:05 INFO - 'LANGUAGE': 'en_US:en', 05:45:05 INFO - 'LOGNAME': 'cltbld', 05:45:05 INFO - 'MAIL': '/var/mail/cltbld', 05:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:05 INFO - 'MOZ_NO_REMOTE': '1', 05:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:05 INFO - 'NO_EM_RESTART': '1', 05:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:05 INFO - 'SHELL': '/bin/bash', 05:45:05 INFO - 'SHLVL': '1', 05:45:05 INFO - 'TERM': 'linux', 05:45:05 INFO - 'TMOUT': '86400', 05:45:05 INFO - 'USER': 'cltbld', 05:45:05 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:05 INFO - '_': '/tools/buildbot/bin/python'} 05:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:06 INFO - Downloading/unpacking jsonschema 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:06 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 05:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:07 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 05:45:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:07 INFO - warning: no files found matching '*.txt' 05:45:07 INFO - no previously-included directories found matching 'build' 05:45:07 INFO - no previously-included directories found matching 'dist' 05:45:07 INFO - no previously-included directories found matching '.git*' 05:45:07 INFO - Installing collected packages: jsonschema, functools32 05:45:08 INFO - Running setup.py install for functools32 05:45:08 INFO - warning: no files found matching '*.txt' 05:45:08 INFO - no previously-included directories found matching 'build' 05:45:08 INFO - no previously-included directories found matching 'dist' 05:45:08 INFO - no previously-included directories found matching '.git*' 05:45:08 INFO - Successfully installed jsonschema functools32 05:45:08 INFO - Cleaning up... 05:45:08 INFO - Return code: 0 05:45:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f95af89df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, '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': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', '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 05:45:08 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 05:45:08 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 05:45:08 INFO - Using env: {'DISPLAY': ':0', 05:45:08 INFO - 'HOME': '/home/cltbld', 05:45:08 INFO - 'LANG': 'en_US.UTF-8', 05:45:08 INFO - 'LANGUAGE': 'en_US:en', 05:45:08 INFO - 'LOGNAME': 'cltbld', 05:45:08 INFO - 'MAIL': '/var/mail/cltbld', 05:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:08 INFO - 'MOZ_NO_REMOTE': '1', 05:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:08 INFO - 'NO_EM_RESTART': '1', 05:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:08 INFO - 'SHELL': '/bin/bash', 05:45:08 INFO - 'SHLVL': '1', 05:45:08 INFO - 'TERM': 'linux', 05:45:08 INFO - 'TMOUT': '86400', 05:45:08 INFO - 'USER': 'cltbld', 05:45:08 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:08 INFO - '_': '/tools/buildbot/bin/python'} 05:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:08 INFO - Downloading/unpacking flake8 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:10 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 05:45:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:10 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 05:45:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 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 05:45:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:10 INFO - no previously-included directories found matching 'docs/_build' 05:45:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:10 INFO - Running setup.py install for pep8 05:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:10 INFO - no previously-included directories found matching 'docs/_build' 05:45:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:10 INFO - Cleaning up... 05:45:10 INFO - Return code: 0 05:45:10 INFO - Running post-action listener: _resource_record_post_action 05:45:10 INFO - Running post-action listener: _start_resource_monitoring 05:45:10 INFO - Starting resource monitoring. 05:45:10 INFO - ##### 05:45:10 INFO - ##### Running install step. 05:45:10 INFO - ##### 05:45:10 INFO - Running pre-action listener: _resource_record_pre_action 05:45:10 INFO - Running main action method: install 05:45:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:11 INFO - Reading from file tmpfile_stdout 05:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:11 INFO - Reading from file tmpfile_stdout 05:45:11 INFO - Output received: 05:45:11 INFO - Usage: mozinstall [options] installer 05:45:11 INFO - Options: 05:45:11 INFO - -h, --help show this help message and exit 05:45:11 INFO - -d DEST, --destination=DEST 05:45:11 INFO - Directory to install application into. [default: 05:45:11 INFO - "/builds/slave/test-pgo"] 05:45:11 INFO - --app=APP Application being installed. [default: firefox] 05:45:11 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:11 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'] 05:45:11 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 05:45:27 INFO - Reading from file tmpfile_stdout 05:45:27 INFO - Output received: 05:45:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:27 INFO - Running post-action listener: _resource_record_post_action 05:45:27 INFO - ##### 05:45:27 INFO - ##### Running run-tests step. 05:45:27 INFO - ##### 05:45:27 INFO - Running pre-action listener: _resource_record_pre_action 05:45:27 INFO - Running main action method: run_tests 05:45:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:27 INFO - Python 2.7.3 05:45:27 INFO - Return code: 0 05:45:27 INFO - grabbing minidump binary from tooltool 05:45: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')]} 05:45:27 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 0x2545540>, '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 0x2546440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25468f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:27 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 05:45:27 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 05:45:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:27 INFO - Return code: 0 05:45:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:45:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:45:28 INFO - Return code: 0 05:45:28 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/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:45:28 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/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 05:45:28 INFO - Using env: {'DISPLAY': ':0', 05:45:28 INFO - 'HOME': '/home/cltbld', 05:45:28 INFO - 'LANG': 'en_US.UTF-8', 05:45:28 INFO - 'LANGUAGE': 'en_US:en', 05:45:28 INFO - 'LOGNAME': 'cltbld', 05:45:28 INFO - 'MAIL': '/var/mail/cltbld', 05:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:28 INFO - 'MOZ_NO_REMOTE': '1', 05:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:28 INFO - 'NO_EM_RESTART': '1', 05:45:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:45:28 INFO - 'SHELL': '/bin/bash', 05:45:28 INFO - 'SHLVL': '1', 05:45:28 INFO - 'TERM': 'linux', 05:45:28 INFO - 'TMOUT': '86400', 05:45:28 INFO - 'USER': 'cltbld', 05:45:28 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489', 05:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:28 INFO - '_': '/tools/buildbot/bin/python'} 05:45:28 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/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 05:45:28 INFO - mozversion application_buildid: 20151230030234 05:45:28 INFO - mozversion application_changeset: c690c50b2b543b420803e8192d6e08e06b20e0a3 05:45:28 INFO - mozversion application_display_name: Nightly 05:45:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:28 INFO - mozversion application_name: Firefox 05:45:28 INFO - mozversion application_remotingname: firefox 05:45:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:45:28 INFO - mozversion application_vendor: Mozilla 05:45:28 INFO - mozversion application_version: 46.0a1 05:45:28 INFO - mozversion platform_buildid: 20151230030234 05:45:28 INFO - mozversion platform_changeset: c690c50b2b543b420803e8192d6e08e06b20e0a3 05:45:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:45:28 INFO - mozversion platform_version: 46.0a1 05:45:28 INFO - using testdate: 1451483128 05:45:28 INFO - actual date: 1451483128 05:45:28 INFO - starting webserver on 'localhost:59731' 05:45:28 INFO - SUITE-START | Running 3 tests 05:45:28 INFO - TEST-START | dromaeo_css 05:45:28 INFO - operating with platform_type : linux_ 05:45:28 INFO - Initialising browser for dromaeo_css test... 05:45:28 INFO - TEST-INFO | started process 8419 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE3sCvA/profile http://localhost:59731/getInfo.html) 05:45:32 INFO - PROCESS | 8419 | __metrics Screen width/height:1600/1200 05:45:32 INFO - PROCESS | 8419 | colorDepth:24 05:45:32 INFO - PROCESS | 8419 | Browser inner width/height: 1024/697 05:45:32 INFO - PROCESS | 8419 | __metrics 05:45:32 INFO - PROCESS | 8419 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:45:32 INFO - PROCESS | 8419 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:33 INFO - TEST-INFO | 8419: exit 0 05:45:33 INFO - Browser initialized. 05:45:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:33 INFO - TEST-INFO | started process 8513 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE3sCvA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:45 INFO - PROCESS | 8513 | RSS: Main: 149319680 05:45:45 INFO - PROCESS | 8513 | 05:46:36 INFO - PROCESS | 8513 | 1451483196194 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] 05:48:45 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59731/tests/dromaeo/cssquery-ext.html) 05:48:46 INFO - PROCESS | 8513 | RSS: Main: 253161472 05:48:46 INFO - PROCESS | 8513 | 05:51:49 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-ext.html (next: http://localhost:59731/tests/dromaeo/cssquery-jquery.html) 05:51:49 INFO - PROCESS | 8513 | RSS: Main: 234250240 05:51:49 INFO - PROCESS | 8513 | 05:54:51 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59731/tests/dromaeo/cssquery-mootools.html) 05:54:52 INFO - PROCESS | 8513 | RSS: Main: 234278912 05:54:52 INFO - PROCESS | 8513 | 05:57:54 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59731/tests/dromaeo/cssquery-prototype.html) 05:57:54 INFO - PROCESS | 8513 | RSS: Main: 215420928 05:57:54 INFO - PROCESS | 8513 | 06:00:57 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59731/tests/dromaeo/cssquery-yui.html) 06:00:57 INFO - PROCESS | 8513 | RSS: Main: 217772032 06:00:57 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | Cycle 1(1): loaded http://localhost:59731/tests/dromaeo/cssquery-yui.html (next: http://localhost:59731/tests/dromaeo/cssquery-dojo.html) 06:04:00 INFO - PROCESS | 8513 | RSS: Main: 279916544 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | __start_tp_report 06:04:00 INFO - PROCESS | 8513 | _x_x_mozilla_page_load 06:04:00 INFO - PROCESS | 8513 | _x_x_mozilla_page_load_details 06:04:00 INFO - PROCESS | 8513 | |i|pagename|runs| 06:04:00 INFO - PROCESS | 8513 | |0;dojo.html;3153.495440729483;3197.0249074032413;3256.218507558185;3257.136858732435;3282.8522716477764;5225.581953443725;5304.814331498398;5353.250544923709;5397.271368365269;5451.727413629323;5340.145576707728;5358.196270559418;5367.409584945653;5403.459654034595;5444.210589464526;4846.757662116897;4918.2376731606655;4932.950670493285;4977.825776097838;4980.178270585349;4881.4874438184015;4960.578350840165;4962.851114466572;4984.675996060245;5060.190369540875;4816.397950256218;5005.424376196747;5012.72430016349;5080.517350851663;5117.769700363474;4853.708777473363;4942.258661200813;5007.12375334315;5014.548690617826;5024.84925452237;4907.828226012108;4908.607311415114;4922.310876477296;4927.802887884516;4951.158303088448;5123.692578445268;5221;5248.921266181011;5249.737513124367;5261.5264626183825;5524.254225679562;5679.204911312419;5688.146777983295;5690.943090569124;5723.570732195102;5834.183214349994;5842.912356314659;5854.47309742121;5856.824295271149;5859.619124756877;5435.130379139358;5445.292112025451;5447;5447.373552041566;5453.863653408617;5692.23154874095;5775.364709881909;5798.246227990334;5800.59395842287;5890.263717035371;5620.4660557247;5624.353199382042;5626.381098079208;5631.493165615032;5675.290588676416;5641.80253691127;5696;5705;5707.286589176353;5722.828315150552;5546.389897111315;5613.7193140342815;5661.264035675335;5700.401457846866;5710.3433105193435;5672.688002159838;5716.685582292931;5719.199312096227;5722.313322401255;5728.48443640066;4376.40918476008;4426.336049592587;4428.579284967923;4438.378626992224;4474.239379305526;3911.1395492992065;3973.046468847456;3980.5621381647998;3991.1020020495157;4013.0368711509614;5367.570594352443;5368.141097424472;5370.543503802221;5371.62398632092;5375.4624537546715;5579.9163012554845;5684.8294551163535;5846.269216347957;5850.678212698343;5853.443922827325;5177.352830896138;5258.7370631468275;5308.867278318073;5333.946660533423;5382.515573598395;4910.484399138039;4914.533119353656;4914.557689807934;4918.434380046269;4957.851264462072;5672.347680016768;5762.078067509178;5764.308283006066;5776.104703770922;5784.82645520635;5545.750441230235;5713.371529131709;5818.592698511064;5828.417158284137;5830.5627077968475;5854.765809367577;5862.7654893805475;5864.384239654775;5864.560157988082;5870.735816888165;5748.655080695172;5752.741126649227;5755.539556835527;5759.625624334405;5772.336181339199;5647.265855438766;5737.454941780524;5752;5752.68360240174;5840.883182336244;5590.692511911884;5619.522340601095;5633.802816901389;5636.21093046982;5636.689982051026;5581.469760372758;5610.270664813548;5637.126245431965;5637.2107904894165;5642.802501912413;5394.217838413487;5447.645903016291;5511.751971161227;5514.558835293086;5577.135543990688;5510.256115424527;5539.113741801292;5539.556835453073;5543.3902270751;5577.6653400796085;5431.913617276639;5440.700761458158;5444.401115877329;5445;5458.754356053908 06:04:00 INFO - PROCESS | 8513 | |1;ext.html;510.8084468324376;549.9715531955244;554.9084401073823;563.540714317831;569.6496654557446;28283.434331313387;28816.13551593453;28854;28857.711422885764;28877.27806804831;28893;29370;36991.44512832303;37582;37686.811565942204;8477.618507167177;8588.312934965219;8631.136886311382;8635.43869648474;8639.222469977702;7588.848223035536;8420.24217820396;8537.10360412157;8547.401681882271;8553.914460855405;7523.548587084765;10112.191024718006;10247.282690211689;10281.177505799555;10305.948470257637;9926.950365248164;10029.749256268578;10030.648927287582;10034.69895903124;10060.195184385231;7618.923810761877;7764.456488045839;7776.066871975343;9810.362326448758;9976.251781116445;39966.80016599898;40987.7950610245;41045.79477102625;41046.1790764183;41061.178776424305;3338.88313909012;3384.9323013539592;3498.702610278129;3516.1033936346325;3861.6331448512346;26145.346366340804;26222;26627.73372266272;26812.329691757666;26911;3413.607435144965;3426.1777173478436;3455.706264967481;3513.9824300878586;3555.5733312002467;223842;227247;228377;228637;229735;55080;55479;55492.72253638787;55506.16740748892;55539;60004;60084.39915600788;60228.698856505434;60283;60380.3771773695;15896.920515397349;16055.839441605667;16161.515154545383;16223.756643650355;16233.67532649364;12103.757924841453;12256.693582660326;12257.26456412618;12260.32568208757;12262.386880655931;19477.415677529698;20197.899010504854;20210.494737631678;20216.292429764886;20237.190512379635;7524.209957954336;7593.164751877289;7656.3874890008665;7741.61291935401;7802.531848089133;880.366136381804;918.2699753695695;940.9670661526951;972.6206779356057;1057.6721216422934;25166.874165629055;25440.872795635903;27999.860000699868;29139;29238.56142157869;978.6868202175378;990.5938565188238;1053.3100818963592;1090.7763908398758;1093.3603841752504;13319.334033298297;13375;13433.126846754929;13488.258145802076;13564.321783910766;327027;327901;328076;328425;328455.51217122335;44035;45034.32448513275;49856.750716246184;50507;50611.746941265796;1342.5166939901628;1352.2359866675297;1355.6678613739698;1357.5248662968079;1360.3266383140408;24981.125660601792;25382.61926071147;25937.6109358356;26124.34689132787;30436.543451847796;40159.1968160641;40188.397174043;40920.1815963685;41004;41134.1773164541;236948;238364;238714;238828;239792;30117.849410752806;30440.543391848696;30454.54318185185;30994.225144371572;31155;38291.425628615034;38436.42345364878;43239.56760432355;43309;44323.556764431945;35800.46299305565;35872;36735.63264367429;37062.814685926394;37078.6292137086;34802.82598586991;35145.89848508173;35512;35803.28393432169;36057.27885442224;35233.1191720209;35467.645323546436;35676.82161589176;36172.63827361798;36677.63322366849;27780.722192778623;29846.701532984393;30028.249293766956;30147.698523015366;30205.546916795825;23140.652890206322;23837.165699200446;23910.28269151928;23982.52034959326;24044.39889002789 06:04:00 INFO - PROCESS | 8513 | |2;jquery.html;358.63598447575714;366.3936185612811;368.37560335231774;369.796611863475;369.80954808273736;13926.303684815744;14035.859641403584;16106.114163721006;16436.424725134624;16983.320667173313;15717.764233536505;15757.684846303067;15917.204139793022;16388.83611163888;16436.67126657466;5309.654872433289;5430.294061771984;5433.565314774828;5436.700981446019;5441.5102640762325;4049.8380064797375;4100.466939297887;5387.057264978633;5428.294321738169;5842.298924129089;5915.526757859382;5945.554083443737;5975.282966044059;5976.701164941757;5980.671063091529;5762.279715035621;5884.411558844081;5927.2590926134235;5933.970330148343;5942.732577034044;5209.557187639055;5251.501107394792;5253.343332083489;5257.553107985826;5259.184826351921;18676.719849202273;20366.389008329774;20409.4897627559;20608.793912060988;21117.47206319839;2319.1187348807343;2369.2655276864225;2397.6643269942224;2401.3756423329887;2457.3242358351417;9083.409578377385;9323.300752443525;9380.202682771973;9453.858192127123;9490.335676502647;1790.2838864454193;1807.159670753093;1843.7050071988551;1845.4002449204063;1885.4626431466966;56967.43032569663;58798.70600647012;58812;59077.99999999957;59549.70225148847;10067.848982265272;10085.546150423248;10117.645882394081;10129.645462408927;10160.08559229658;13287.867121328663;13303.600891973256;13322.267275299952;13332.066755327229;13350.799738003938;7765.495242809199;7829.982102326775;7849;7882.802929926797;7894.64474098667;7237.421006319481;7338.4496162788;7342;7354;7565.335626162236;4296.806643701041;4334.674899382559;4367.934480982788;4404.405405270311;4407.691461597721;1768.7789026371704;1784.4111443223705;1816.845568126724;1850.1406086882866;1852.8054554271878;912.5163663258484;936.828963795256;948.7628092976756;991.3011327014437;1005.8038682456851;16767.664646707242;17149.314027439013;17182.22679979379;17318.480445586654;17625.559361016076;826.3969094746899;900.6712549919232;933.09955892564;933.118203297877;1016.6441745389054;6651.733930642817;9106.908930910738;9177.357584968988;9209.723708288628;9293;405801;408457;409292;579869;589058;39508.802455987534;60430;66292.668536657;69738.65130674314;70935.64532177306;1165.516310731037;1165.5920427850185;1174.9060075193963;1186.6024881664566;1196.0132890365483;15707;15827.36690532412;15924.601884952968;15988.600284992503;16281.267342969359;35350.82324588361;36885.81557092197;36948;36985;37401.62598373982;46349.53650463587;47020.7648961753;48753.2687009688;48863;49337.75331123322;9145.77135571616;9485.098915603006;9488.810223795623;9558.139767420966;9563.474008929576;11206.38364889939;11306.830397544209;11387.54449822031;11681.88318116808;16462.835371646608;13491;13710.862891370958;14184;14306.284685765462;14309.785353219502;13714.382852771849;13767.862321376659;13882;13892.23592702411;14217.218053007184;14009.08940918837;14044.508442204473;14216.21810800416;14417.423303068179;14726.484573039892;9374.203192728695;9679.612815487302;9718.951405242928;9895.406275623485;9900.702978910644;10458.215633827645;11883.82174267404;14066.78899816524;14419.495317663832;15171.393144274105 06:04:00 INFO - PROCESS | 8513 | |3;mootools.html;1337.1509091726762;1496.461273941381;1522.535626633877;1699.1419333236722;1841.0242571437134;6764.32356764324;7311.3785328247095;7402.259774022602;7410.740624078158;7413.147488038877;7274;7482.4762266641355;7484.476086673922;7493.887591686115;7496.062992125984;2045.8772473651554;2078.8025137611903;2079.4177630263475;2277.87471689057;2312.167619656922;2293.1515339324474;2321.292005938188;2326.5463234669246;2326.8836558172106;2327.3367090379247;2272.1479445208047;2294.827887908405;2310.2260742651147;2325.6278995360744;2330.883455827202;2281.703378560793;2296.0930432479163;2325.5232677301196;2328.1269523928527;2338.1232037985756;2308.826837987158;2337.922477839062;2344.882755862217;2345.1791872844537;2358.0332063853907;7574.734884279023;7669.271419215165;7676.577788221645;7679.539227646359;7699.5380277182985;4600.17196904557;4715.1512727709;4719.858404247878;4721.551452611996;4725.40932383452;3178.1895616617844;3188.1232661018175;3196.7282780963646;3254.902352929416;3306.93386132276;966.2173639352147;973.090160699748;1024.1243736605245;1028.7273872423739;1058.6453538064682;10705.785884282348;10706.571737130505;10719.78560428787;10725.678229653124;10729.624463143753;4194.769287689206;4201.369794530845;4278;4315.8489452869;4327.82688692455;8759.386842920934;8804.075572064969;8843.380963332505;8849.867251991225;8872.157145071207;4725.1730947084125;4729.361536192639;4732.716037037789;4735.763211839463;4748.477667456577;4313.396124542566;4347.5217726050105;4356.150550642595;4371.431713877176;4378.64970802335;3442.0534353053113;3470.6876381125317;3630.9636903630626;3683.852645894188;3772.396416573335;1188.6849984754047;1191.2197510630551;1196.9461374238006;1207.0223119273242;1213.660175150959;992.1913640383065;1008.6520150548049;1052.3002203534718;1052.7315534538798;1087.3910610058392;7020.929790702027;7060.7528736495005;7072.267294512877;7073.434125269966;7089.964550177319;1102.7573933734566;1110.35044498969;1131.8698349689892;1138.282881784487;1165.7085728567858;5658.377578466366;5773.711314434261;5786.392428794916;5787.768489260382;5793.710314484343;8884.156005179497;9344.34589578723;9353.251739860794;9446.952765236267;9460;9316.068393160629;9346.0653934606;9421;9423.717288481357;9426.95286523563;7125.073740413816;7229.602371869492;7247.4926755126635;7286.052813134259;7289.927100729031;6985;7019.929800702132;7023.789286321418;7036.964815176096;7040.190378106583;7800.531968081933;7838.098618658927;7983;8086.676532938616;8087.514749115072;8161.551114688749;8164.428490005643;8172.632231549714;8291.295239904675;8295.087540370676;6779.661016949231;6941.2364639888565;6959.826004349932;6971.65141742921;6973.12835895513;6598.472122230306;6686.465082793462;7093.077899872984;7241.927580724126;7310.195878453473;6833.077534532973;6881.827954301182;6922.169339679271;6977.406920411619;7010.123734533184;6721.93278067213;6735.191776986793;6828.7268509259075;6851.862962740617;6896.310368963063;6974.442044636518;7006.929930700628;7023.68393422287;7034.753783617549;7057.929420705727;6302.149209856794;6318.526110541636;6363.172787537591;6367.61794292344;6410.583312084699;6481;6505.349465053457;6541.411272985454;6555.967220163869;6580.276169621242 06:04:00 INFO - PROCESS | 8513 | |4;prototype.html;338.0770496544434;338.41116457364177;344.4677972532437;344.70527698817517;351.978881267124;5873.236479257701;5941.5246780257585;6012.699365031747;6024.0963855421705;6030.608010479321;5782.045962416196;5920.792772252972;5923.496502797257;5938.346781854003;5954.851128721773;4598.149342371656;4601.976990115061;4610.400647915766;4612.607928326096;4615.630749540045;4401.955980440202;4459.197344478009;4503.617192538622;4573.382593349905;4617.46899106602;4537.546245375453;4537.795799189028;4557.065801510682;4567.429071366079;4578.198815207342;4570.880134367101;4577.427821522327;4579.015511664975;4579.198640237978;4581.496035436099;4017.9397309040387;4026.979865100656;4030.7581545107387;4036.939445908284;4040.5353384360587;5567.916481252784;5664.2636457260705;5674.092145256739;5683.090705487102;5702.885942281131;5276.683398996072;5288.1538953767595;5289.418164001957;5293.444188360205;5294.417614062489;6063.575549711522;6340.112384266206;6344.904826427561;6352.301246862841;6356.586821856611;4233.534311225793;4313.97843010783;4336.02439451121;4343.2182207202695;4349.499807522144;6497.18785151856;6580.407763301278;6590.472762179063;6601.009848522712;6601.63690996995;4506.1213063452315;4508.932366014513;4516.638668906479;4517.932231016537;4524.389207456951;4461.598456138963;4567.200739870509;4575.519570445122;4578.931316030262;4582.427196600425;5265.131253343232;5269.367675878919;5269.4730526947;5273.156294992783;5275.261463395128;6342.429181373698;6347;6350.809475715643;6353.618782873043;6357.682115894187;1588.626672731907;1609.2919115589104;1622.594351412147;1622.6592415592622;1624.3746157729122;1067.2475904487317;1067.6903697927514;1076.7469644633504;1077.671310250381;1110.123002827757;5945.137954996501;5946.226990491295;5948.315943666534;5948.940510594839;5954.404559544011;6557.5081868860025;6567.4417674497245;6578.473722102221;6581.736730530821;6591.011348297794;5848.619839710405;5961.135635332853;5971.343152253248;5971.671558064261;5975.641461512237;3539.5752509698486;3557.768745031565;3563.572371315407;3566.5006899034156;3567.6432356764635;6594.637294948728;6599.637019963852;6602.834929126714;6607.537472376984;6613.239477460057;6709.127813384229;6743.696533655997;6754.223264324567;6756.324367563303;6759.662016899136;6468.223813142359;6625.271220165778;6632.2704502504685;6643.534952553275;6697.09589205451;6334.90497642545;6482.935170648233;6662.833429164116;6665.566738162004;6670.899936500859;6370.55406121567;6515.381038801306;6530.379613936669;6561.278259391368;6568.244651865097;6614.371634694697;6615.17310336208;6615.536912416084;6624.403803657694;6633.900491492535;4379.321205213197;4502.189605870974;4527.909441811211;4529.456465224194;4532.342810292555;6600.570962887397;6612.966935165294;6620.8344791380605;6625.271220165681;6629.270780214269;6432.388923052303;6435.871282574416;6436.806895793134;6440.935590644033;6444.871102578016;6270.435660790551;6423.935760642521;6428.839279018062;6434.420902118832;6435.646039467874;6298.0867774171575;6299.08663243818;6301.180846489927;6303.9684801575695;6304.3380445054445;6439.484841212786;6444;6444.581102228528;6445.935540644721;6449.226092868698;6133.50931925436;6285.59143655661;6292.402221788922;6295.370462953668;6317 06:04:00 INFO - PROCESS | 8513 | |5;yui.html;804.6379129391773;807.3178164451036;811.5212024905309;815.4658698552447;827.9130691277412;13466.865331346684;13517.864821351783;13705.794413083811;13785.862141378584;13805.654858628539;13542.39059242334;13590.864091359084;13647.317634118279;13657.931710341434;13694.863051369482;697.5221972948522;705.7071315404102;830.4311546590575;833.8290650416665;854.8888644476209;848.9363297752662;858.6179150278128;863.7236084452977;865.6277800545763;866.0430224601819;892.3708785306344;909.9863502047441;911.2618778789168;911.4485736129612;911.6034524981621;725.0393228971608;734.0787311923528;878.4597472554365;901.7204666553324;904.6788390121544;651.2315467748056;654.3979538824293;661.8246164766341;661.9702113404908;663.187595195886;13125.409356578977;13237.536686216032;13259.27074010929;13264.801027984588;13296.069275150743;11658.242214256046;11686.532538698442;11904.880951190551;11905.821412678817;11965.700857478545;10564.366138031666;10627.78744425115;10657.893421065768;10680.78638427235;10717.35695858251;3599.3341231872187;3678.889633311005;3684.8157592120556;3692.649198326155;3772.981135094307;44667;45042.54957450416;45244;45261;45650.77174614139;10038.347507411994;10215.540300686487;10346.793064138676;10348.948255258827;10386.11718003963;17130.828691713174;17262.05058721757;17269.222884970208;17306.307747689953;17312.40313952917;7332.340089391981;7475;7516.210797866254;7594.582297973665;7607.65765540552;4066.755994640331;4201.327787553977;4255.69888848126;4355.956440435555;4372.1692878353015;3080.9537856932166;3114.377124575094;3116.158637167952;3116.407882502317;3116.9064928052194;567.7473524281655;578.2251782611321;589.7699897040158;592.9407059294036;599.5862854630291;634.2135751667898;663.8904580744123;672.7174586673609;673.8618583190434;691.094665987558;8883.111688831064;9036.683716070038;9191.31065170115;9243.953780231055;9373.718788436357;622.953278504114;675.3955210087042;679.4734081087098;716.7634680555404;727.0548287226584;3682.9447558286647;3719.3119272934596;4008.0581063450068;4049.9797501012895;4080.591940805955;53339.46660533422;55196.448035519934;55269.17096243559;55318.44681553133;55463;45550.54449455463;45656.77171614187;45882.54117458849;49818.501814981384;50299.74850125799;44379.334309985374;44955.55044449579;45038.774806126414;45373.09253814905;45439.046461979866;7874.72438464651;8001;8087.514749115072;8104.149064348158;8273.214044665747;32568.67431325751;32699.34601308008;32922;33695.663043369255;33872.830635846665;38519.42220866633;39599.2080158401;43195.56804431915;43247;43780.56219437765;9946.154576861049;10084.495775211064;10138.543765530716;10334.948325258325;10441;11600.129990250596;11745.706357341134;11833.408329583659;11836.112291577994;12238.204516706386;10327.948360258151;10360.067593916583;10585.9470702646;10933.781324373309;11045.28205666629;10189.694309170736;10337.586496540054;10522.894771052192;10611.09805666527;10733.838992414963;10088.142507886618;10375.221858360805;10493.685189444328;10579.36523808574;10599.417032063002;9312.243118694732;9427.15155635996;9429.858552121586;9507.286953478655;9668;8360.707375241838;8569.843031552284;8804.47173169612;8823.426477278956;9712.854307185256 06:04:00 INFO - PROCESS | 8513 | __end_tp_report 06:04:00 INFO - PROCESS | 8513 | __start_cc_report 06:04:00 INFO - PROCESS | 8513 | _x_x_mozilla_cycle_collect,844 06:04:00 INFO - PROCESS | 8513 | __end_cc_report 06:04:00 INFO - PROCESS | 8513 | __startTimestamp1451484240631__endTimestamp 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | ------- Summary: start ------- 06:04:00 INFO - PROCESS | 8513 | Number of tests: 6 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#0] dojo.html Cycles:165 Average:5325.89 Median:5510.26 stddev:566.86 (10.3%) stddev-sans-first:542.37 06:04:00 INFO - PROCESS | 8513 | Values: 3153.5 3197.0 3256.2 3257.1 3282.9 5225.6 5304.8 5353.3 5397.3 5451.7 5340.1 5358.2 5367.4 5403.5 5444.2 4846.8 4918.2 4933.0 4977.8 4980.2 4881.5 4960.6 4962.9 4984.7 5060.2 4816.4 5005.4 5012.7 5080.5 5117.8 4853.7 4942.3 5007.1 5014.5 5024.8 4907.8 4908.6 4922.3 4927.8 4951.2 5123.7 5221.0 5248.9 5249.7 5261.5 5524.3 5679.2 5688.1 5690.9 5723.6 5834.2 5842.9 5854.5 5856.8 5859.6 5435.1 5445.3 5447.0 5447.4 5453.9 5692.2 5775.4 5798.2 5800.6 5890.3 5620.5 5624.4 5626.4 5631.5 5675.3 5641.8 5696.0 5705.0 5707.3 5722.8 5546.4 5613.7 5661.3 5700.4 5710.3 5672.7 5716.7 5719.2 5722.3 5728.5 4376.4 4426.3 4428.6 4438.4 4474.2 3911.1 3973.0 3980.6 3991.1 4013.0 5367.6 5368.1 5370.5 5371.6 5375.5 5579.9 5684.8 5846.3 5850.7 5853.4 5177.4 5258.7 5308.9 5333.9 5382.5 4910.5 4914.5 4914.6 4918.4 4957.9 5672.3 5762.1 5764.3 5776.1 5784.8 5545.8 5713.4 5818.6 5828.4 5830.6 5854.8 5862.8 5864.4 5864.6 5870.7 5748.7 5752.7 5755.5 5759.6 5772.3 5647.3 5737.5 5752.0 5752.7 5840.9 5590.7 5619.5 5633.8 5636.2 5636.7 5581.5 5610.3 5637.1 5637.2 5642.8 5394.2 5447.6 5511.8 5514.6 5577.1 5510.3 5539.1 5539.6 5543.4 5577.7 5431.9 5440.7 5444.4 5445.0 5458.8 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#1] ext.html Cycles:180 Average:42820.52 Median:3399.27 stddev:70162.14 (2064.0%) stddev-sans-first:70287.05 06:04:00 INFO - PROCESS | 8513 | Values: 510.8 550.0 554.9 563.5 569.6 28283.4 28816.1 28854.0 28857.7 28877.3 28893.0 29370.0 36991.4 37582.0 37686.8 8477.6 8588.3 8631.1 8635.4 8639.2 7588.8 8420.2 8537.1 8547.4 8553.9 7523.5 10112.2 10247.3 10281.2 10305.9 9927.0 10029.7 10030.6 10034.7 10060.2 7618.9 7764.5 7776.1 9810.4 9976.3 39966.8 40987.8 41045.8 41046.2 41061.2 3338.9 3384.9 3498.7 3516.1 3861.6 26145.3 26222.0 26627.7 26812.3 26911.0 3413.6 3426.2 3455.7 3514.0 3555.6 223842.0 227247.0 228377.0 228637.0 229735.0 55080.0 55479.0 55492.7 55506.2 55539.0 60004.0 60084.4 60228.7 60283.0 60380.4 15896.9 16055.8 16161.5 16223.8 16233.7 12103.8 12256.7 12257.3 12260.3 12262.4 19477.4 20197.9 20210.5 20216.3 20237.2 7524.2 7593.2 7656.4 7741.6 7802.5 880.4 918.3 941.0 972.6 1057.7 25166.9 25440.9 27999.9 29139.0 29238.6 978.7 990.6 1053.3 1090.8 1093.4 13319.3 13375.0 13433.1 13488.3 13564.3 327027.0 327901.0 328076.0 328425.0 328455.5 44035.0 45034.3 49856.8 50507.0 50611.7 1342.5 1352.2 1355.7 1357.5 1360.3 24981.1 25382.6 25937.6 26124.3 30436.5 40159.2 40188.4 40920.2 41004.0 41134.2 236948.0 238364.0 238714.0 238828.0 239792.0 30117.8 30440.5 30454.5 30994.2 31155.0 38291.4 38436.4 43239.6 43309.0 44323.6 35800.5 35872.0 36735.6 37062.8 37078.6 34802.8 35145.9 35512.0 35803.3 36057.3 35233.1 35467.6 35676.8 36172.6 36677.6 27780.7 29846.7 30028.2 30147.7 30205.5 23140.7 23837.2 23910.3 23982.5 24044.4 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#2] jquery.html Cycles:180 Average:26476.31 Median:37193.31 stddev:79371.96 (213.4%) stddev-sans-first:79570.39 06:04:00 INFO - PROCESS | 8513 | Values: 358.6 366.4 368.4 369.8 369.8 13926.3 14035.9 16106.1 16436.4 16983.3 15717.8 15757.7 15917.2 16388.8 16436.7 5309.7 5430.3 5433.6 5436.7 5441.5 4049.8 4100.5 5387.1 5428.3 5842.3 5915.5 5945.6 5975.3 5976.7 5980.7 5762.3 5884.4 5927.3 5934.0 5942.7 5209.6 5251.5 5253.3 5257.6 5259.2 18676.7 20366.4 20409.5 20608.8 21117.5 2319.1 2369.3 2397.7 2401.4 2457.3 9083.4 9323.3 9380.2 9453.9 9490.3 1790.3 1807.2 1843.7 1845.4 1885.5 56967.4 58798.7 58812.0 59078.0 59549.7 10067.8 10085.5 10117.6 10129.6 10160.1 13287.9 13303.6 13322.3 13332.1 13350.8 7765.5 7830.0 7849.0 7882.8 7894.6 7237.4 7338.4 7342.0 7354.0 7565.3 4296.8 4334.7 4367.9 4404.4 4407.7 1768.8 1784.4 1816.8 1850.1 1852.8 912.5 936.8 948.8 991.3 1005.8 16767.7 17149.3 17182.2 17318.5 17625.6 826.4 900.7 933.1 933.1 1016.6 6651.7 9106.9 9177.4 9209.7 9293.0 405801.0 408457.0 409292.0 579869.0 589058.0 39508.8 60430.0 66292.7 69738.7 70935.6 1165.5 1165.6 1174.9 1186.6 1196.0 15707.0 15827.4 15924.6 15988.6 16281.3 35350.8 36885.8 36948.0 36985.0 37401.6 46349.5 47020.8 48753.3 48863.0 49337.8 9145.8 9485.1 9488.8 9558.1 9563.5 11206.4 11306.8 11387.5 11681.9 16462.8 13491.0 13710.9 14184.0 14306.3 14309.8 13714.4 13767.9 13882.0 13892.2 14217.2 14009.1 14044.5 14216.2 14417.4 14726.5 9374.2 9679.6 9719.0 9895.4 9900.7 10458.2 11883.8 14066.8 14419.5 15171.4 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#3] mootools.html Cycles:180 Average:5379.61 Median:6389.10 stddev:2746.36 (43.0%) stddev-sans-first:2737.25 06:04:00 INFO - PROCESS | 8513 | Values: 1337.2 1496.5 1522.5 1699.1 1841.0 6764.3 7311.4 7402.3 7410.7 7413.1 7274.0 7482.5 7484.5 7493.9 7496.1 2045.9 2078.8 2079.4 2277.9 2312.2 2293.2 2321.3 2326.5 2326.9 2327.3 2272.1 2294.8 2310.2 2325.6 2330.9 2281.7 2296.1 2325.5 2328.1 2338.1 2308.8 2337.9 2344.9 2345.2 2358.0 7574.7 7669.3 7676.6 7679.5 7699.5 4600.2 4715.2 4719.9 4721.6 4725.4 3178.2 3188.1 3196.7 3254.9 3306.9 966.2 973.1 1024.1 1028.7 1058.6 10705.8 10706.6 10719.8 10725.7 10729.6 4194.8 4201.4 4278.0 4315.8 4327.8 8759.4 8804.1 8843.4 8849.9 8872.2 4725.2 4729.4 4732.7 4735.8 4748.5 4313.4 4347.5 4356.2 4371.4 4378.6 3442.1 3470.7 3631.0 3683.9 3772.4 1188.7 1191.2 1196.9 1207.0 1213.7 992.2 1008.7 1052.3 1052.7 1087.4 7020.9 7060.8 7072.3 7073.4 7090.0 1102.8 1110.4 1131.9 1138.3 1165.7 5658.4 5773.7 5786.4 5787.8 5793.7 8884.2 9344.3 9353.3 9447.0 9460.0 9316.1 9346.1 9421.0 9423.7 9427.0 7125.1 7229.6 7247.5 7286.1 7289.9 6985.0 7019.9 7023.8 7037.0 7040.2 7800.5 7838.1 7983.0 8086.7 8087.5 8161.6 8164.4 8172.6 8291.3 8295.1 6779.7 6941.2 6959.8 6971.7 6973.1 6598.5 6686.5 7093.1 7241.9 7310.2 6833.1 6881.8 6922.2 6977.4 7010.1 6721.9 6735.2 6828.7 6851.9 6896.3 6974.4 7006.9 7023.7 7034.8 7057.9 6302.1 6318.5 6363.2 6367.6 6410.6 6481.0 6505.3 6541.4 6556.0 6580.3 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#4] prototype.html Cycles:180 Average:5296.09 Median:5951.67 stddev:1590.65 (26.7%) stddev-sans-first:1550.97 06:04:00 INFO - PROCESS | 8513 | Values: 338.1 338.4 344.5 344.7 352.0 5873.2 5941.5 6012.7 6024.1 6030.6 5782.0 5920.8 5923.5 5938.3 5954.9 4598.1 4602.0 4610.4 4612.6 4615.6 4402.0 4459.2 4503.6 4573.4 4617.5 4537.5 4537.8 4557.1 4567.4 4578.2 4570.9 4577.4 4579.0 4579.2 4581.5 4017.9 4027.0 4030.8 4036.9 4040.5 5567.9 5664.3 5674.1 5683.1 5702.9 5276.7 5288.2 5289.4 5293.4 5294.4 6063.6 6340.1 6344.9 6352.3 6356.6 4233.5 4314.0 4336.0 4343.2 4349.5 6497.2 6580.4 6590.5 6601.0 6601.6 4506.1 4508.9 4516.6 4517.9 4524.4 4461.6 4567.2 4575.5 4578.9 4582.4 5265.1 5269.4 5269.5 5273.2 5275.3 6342.4 6347.0 6350.8 6353.6 6357.7 1588.6 1609.3 1622.6 1622.7 1624.4 1067.2 1067.7 1076.7 1077.7 1110.1 5945.1 5946.2 5948.3 5948.9 5954.4 6557.5 6567.4 6578.5 6581.7 6591.0 5848.6 5961.1 5971.3 5971.7 5975.6 3539.6 3557.8 3563.6 3566.5 3567.6 6594.6 6599.6 6602.8 6607.5 6613.2 6709.1 6743.7 6754.2 6756.3 6759.7 6468.2 6625.3 6632.3 6643.5 6697.1 6334.9 6482.9 6662.8 6665.6 6670.9 6370.6 6515.4 6530.4 6561.3 6568.2 6614.4 6615.2 6615.5 6624.4 6633.9 4379.3 4502.2 4527.9 4529.5 4532.3 6600.6 6613.0 6620.8 6625.3 6629.3 6432.4 6435.9 6436.8 6440.9 6444.9 6270.4 6423.9 6428.8 6434.4 6435.6 6298.1 6299.1 6301.2 6304.0 6304.3 6439.5 6444.0 6444.6 6445.9 6449.2 6133.5 6285.6 6292.4 6295.4 6317.0 06:04:00 INFO - PROCESS | 8513 | 06:04:00 INFO - PROCESS | 8513 | [#5] yui.html Cycles:180 Average:13230.23 Median:44811.28 stddev:15037.68 (33.6%) stddev-sans-first:15050.91 06:04:00 INFO - PROCESS | 8513 | Values: 804.6 807.3 811.5 815.5 827.9 13466.9 13517.9 13705.8 13785.9 13805.7 13542.4 13590.9 13647.3 13657.9 13694.9 697.5 705.7 830.4 833.8 854.9 848.9 858.6 863.7 865.6 866.0 892.4 910.0 911.3 911.4 911.6 725.0 734.1 878.5 901.7 904.7 651.2 654.4 661.8 662.0 663.2 13125.4 13237.5 13259.3 13264.8 13296.1 11658.2 11686.5 11904.9 11905.8 11965.7 10564.4 10627.8 10657.9 10680.8 10717.4 3599.3 3678.9 3684.8 3692.6 3773.0 44667.0 45042.5 45244.0 45261.0 45650.8 10038.3 10215.5 10346.8 10348.9 10386.1 17130.8 17262.1 17269.2 17306.3 17312.4 7332.3 7475.0 7516.2 7594.6 7607.7 4066.8 4201.3 4255.7 4356.0 4372.2 3081.0 3114.4 3116.2 3116.4 3116.9 567.7 578.2 589.8 592.9 599.6 634.2 663.9 672.7 673.9 691.1 8883.1 9036.7 9191.3 9244.0 9373.7 623.0 675.4 679.5 716.8 727.1 3682.9 3719.3 4008.1 4050.0 4080.6 53339.5 55196.4 55269.2 55318.4 55463.0 45550.5 45656.8 45882.5 49818.5 50299.7 44379.3 44955.6 45038.8 45373.1 45439.0 7874.7 8001.0 8087.5 8104.1 8273.2 32568.7 32699.3 32922.0 33695.7 33872.8 38519.4 39599.2 43195.6 43247.0 43780.6 9946.2 10084.5 10138.5 10334.9 10441.0 11600.1 11745.7 11833.4 11836.1 12238.2 10327.9 10360.1 10585.9 10933.8 11045.3 10189.7 10337.6 10522.9 10611.1 10733.8 10088.1 10375.2 10493.7 10579.4 10599.4 9312.2 9427.2 9429.9 9507.3 9668.0 8360.7 8569.8 8804.5 8823.4 9712.9 06:04:00 INFO - PROCESS | 8513 | -------- Summary: end -------- 06:04:00 INFO - PROCESS | 8513 | 06:04:01 INFO - TEST-INFO | 8513: exit 0 06:04:01 INFO - TEST-OK | dromaeo_css | took 1112967ms 06:04:01 INFO - TEST-START | kraken 06:04:01 INFO - operating with platform_type : linux_ 06:04:01 INFO - Initialising browser for kraken test... 06:04:01 INFO - TEST-INFO | started process 8708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpalnlC8/profile http://localhost:59731/getInfo.html) 06:04:05 INFO - PROCESS | 8708 | __metrics Screen width/height:1600/1200 06:04:05 INFO - PROCESS | 8708 | colorDepth:24 06:04:05 INFO - PROCESS | 8708 | Browser inner width/height: 1024/697 06:04:05 INFO - PROCESS | 8708 | __metrics 06:04:05 INFO - PROCESS | 8708 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:04:05 INFO - PROCESS | 8708 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:04:06 INFO - TEST-INFO | 8708: exit 0 06:04:06 INFO - Browser initialized. 06:04:06 INFO - Running cycle 1/1 for kraken test... 06:04:06 INFO - TEST-INFO | started process 8790 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpalnlC8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:18 INFO - PROCESS | 8790 | RSS: Main: 149987328 06:04:18 INFO - PROCESS | 8790 | 06:04:20 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59731/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:21 INFO - PROCESS | 8790 | RSS: Main: 185884672 06:04:21 INFO - PROCESS | 8790 | 06:04:23 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59731/tests/kraken/driver.html?testName=audio-dft) 06:04:24 INFO - PROCESS | 8790 | RSS: Main: 174301184 06:04:24 INFO - PROCESS | 8790 | 06:04:27 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59731/tests/kraken/driver.html?testName=audio-fft) 06:04:28 INFO - PROCESS | 8790 | RSS: Main: 159604736 06:04:28 INFO - PROCESS | 8790 | 06:04:30 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59731/tests/kraken/driver.html?testName=audio-oscillator) 06:04:30 INFO - PROCESS | 8790 | RSS: Main: 161673216 06:04:30 INFO - PROCESS | 8790 | 06:04:32 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:33 INFO - PROCESS | 8790 | RSS: Main: 163258368 06:04:33 INFO - PROCESS | 8790 | 06:04:36 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59731/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:36 INFO - PROCESS | 8790 | RSS: Main: 165244928 06:04:36 INFO - PROCESS | 8790 | 06:04:40 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59731/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:40 INFO - PROCESS | 8790 | RSS: Main: 165015552 06:04:40 INFO - PROCESS | 8790 | 06:04:43 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59731/tests/kraken/driver.html?testName=json-parse-financial) 06:04:44 INFO - PROCESS | 8790 | RSS: Main: 164757504 06:04:44 INFO - PROCESS | 8790 | 06:04:45 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:46 INFO - PROCESS | 8790 | RSS: Main: 176623616 06:04:46 INFO - PROCESS | 8790 | 06:04:48 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:48 INFO - PROCESS | 8790 | RSS: Main: 174276608 06:04:48 INFO - PROCESS | 8790 | 06:04:50 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:51 INFO - PROCESS | 8790 | RSS: Main: 186925056 06:04:51 INFO - PROCESS | 8790 | 06:04:53 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:54 INFO - PROCESS | 8790 | RSS: Main: 195149824 06:04:54 INFO - PROCESS | 8790 | 06:04:56 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:57 INFO - PROCESS | 8790 | RSS: Main: 192483328 06:04:57 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | Cycle 1(1): loaded http://localhost:59731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59731/tests/kraken/driver.html?testName=ai-astar) 06:04:59 INFO - PROCESS | 8790 | RSS: Main: 250875904 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | __start_tp_report 06:04:59 INFO - PROCESS | 8790 | _x_x_mozilla_page_load 06:04:59 INFO - PROCESS | 8790 | _x_x_mozilla_page_load_details 06:04:59 INFO - PROCESS | 8790 | |i|pagename|runs| 06:04:59 INFO - PROCESS | 8790 | |0;ai-astar;111;110;104;111;111;110;102;110;110;101 06:04:59 INFO - PROCESS | 8790 | |1;audio-beat-detection;157;127;149;159;126;153;158;130;165;125 06:04:59 INFO - PROCESS | 8790 | |2;audio-dft;161;160;162;162;163;163;162;161;161;161 06:04:59 INFO - PROCESS | 8790 | |3;audio-fft;73;73;79;99;70;72;75;98;96;73 06:04:59 INFO - PROCESS | 8790 | |4;audio-oscillator;97;103;140;96;96;96;149;96;97;147 06:04:59 INFO - PROCESS | 8790 | |5;imaging-gaussian-blur;110;109;109;110;109;109;109;109;109;109 06:04:59 INFO - PROCESS | 8790 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;145;146 06:04:59 INFO - PROCESS | 8790 | |7;imaging-desaturate;96;96;96;95;97;96;97;96;96;95 06:04:59 INFO - PROCESS | 8790 | |8;json-parse-financial;59;56;60;57;58;57;56;68;55;55 06:04:59 INFO - PROCESS | 8790 | |9;json-stringify-tinderbox;69;68;68;70;69;70;69;68;69;70 06:04:59 INFO - PROCESS | 8790 | |10;stanford-crypto-aes;85;86;87;86;86;89;86;86;87;87 06:04:59 INFO - PROCESS | 8790 | |11;stanford-crypto-ccm;128;117;116;131;115;129;115;117;118;120 06:04:59 INFO - PROCESS | 8790 | |12;stanford-crypto-pbkdf2;142;151;151;150;154;141;150;151;150;141 06:04:59 INFO - PROCESS | 8790 | |13;stanford-crypto-sha256-iterative;68;67;68;72;69;67;72;67;68;66 06:04:59 INFO - PROCESS | 8790 | __end_tp_report 06:04:59 INFO - PROCESS | 8790 | __start_cc_report 06:04:59 INFO - PROCESS | 8790 | _x_x_mozilla_cycle_collect,937 06:04:59 INFO - PROCESS | 8790 | __end_cc_report 06:04:59 INFO - PROCESS | 8790 | __startTimestamp1451484299415__endTimestamp 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | ------- Summary: start ------- 06:04:59 INFO - PROCESS | 8790 | Number of tests: 14 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:4.00 (3.6%) stddev-sans-first:4.09 06:04:59 INFO - PROCESS | 8790 | Values: 111.0 110.0 104.0 111.0 111.0 110.0 102.0 110.0 110.0 101.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:155.00 stddev:15.98 (10.3%) stddev-sans-first:16.34 06:04:59 INFO - PROCESS | 8790 | Values: 157.0 127.0 149.0 159.0 126.0 153.0 158.0 130.0 165.0 125.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 06:04:59 INFO - PROCESS | 8790 | Values: 161.0 160.0 162.0 162.0 163.0 163.0 162.0 161.0 161.0 161.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#3] audio-fft Cycles:10 Average:80.80 Median:77.00 stddev:11.89 (15.4%) stddev-sans-first:12.27 06:04:59 INFO - PROCESS | 8790 | Values: 73.0 73.0 79.0 99.0 70.0 72.0 75.0 98.0 96.0 73.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:23.41 (24.4%) stddev-sans-first:24.22 06:04:59 INFO - PROCESS | 8790 | Values: 97.0 103.0 140.0 96.0 96.0 96.0 149.0 96.0 97.0 147.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:04:59 INFO - PROCESS | 8790 | Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 06:04:59 INFO - PROCESS | 8790 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:04:59 INFO - PROCESS | 8790 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 97.0 96.0 96.0 95.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:3.84 (6.7%) stddev-sans-first:4.06 06:04:59 INFO - PROCESS | 8790 | Values: 59.0 56.0 60.0 57.0 58.0 57.0 56.0 68.0 55.0 55.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:04:59 INFO - PROCESS | 8790 | Values: 69.0 68.0 68.0 70.0 69.0 70.0 69.0 68.0 69.0 70.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:1.08 (1.2%) stddev-sans-first:1.00 06:04:59 INFO - PROCESS | 8790 | Values: 85.0 86.0 87.0 86.0 86.0 89.0 86.0 86.0 87.0 87.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:119.00 stddev:6.24 (5.2%) stddev-sans-first:6.02 06:04:59 INFO - PROCESS | 8790 | Values: 128.0 117.0 116.0 131.0 115.0 129.0 115.0 117.0 118.0 120.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:4.82 (3.2%) stddev-sans-first:4.58 06:04:59 INFO - PROCESS | 8790 | Values: 142.0 151.0 151.0 150.0 154.0 141.0 150.0 151.0 150.0 141.0 06:04:59 INFO - PROCESS | 8790 | 06:04:59 INFO - PROCESS | 8790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.07 (3.0%) stddev-sans-first:2.19 06:04:59 INFO - PROCESS | 8790 | Values: 68.0 67.0 68.0 72.0 69.0 67.0 72.0 67.0 68.0 66.0 06:04:59 INFO - PROCESS | 8790 | -------- Summary: end -------- 06:04:59 INFO - PROCESS | 8790 | 06:05:00 INFO - TEST-INFO | 8790: exit 0 06:05:00 INFO - TEST-OK | kraken | took 58968ms 06:05:00 INFO - TEST-START | v8_7 06:05:00 INFO - operating with platform_type : linux_ 06:05:00 INFO - Initialising browser for v8_7 test... 06:05:00 INFO - TEST-INFO | started process 9039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl02IGs/profile http://localhost:59731/getInfo.html) 06:05:04 INFO - PROCESS | 9039 | __metrics Screen width/height:1600/1200 06:05:04 INFO - PROCESS | 9039 | colorDepth:24 06:05:04 INFO - PROCESS | 9039 | Browser inner width/height: 1024/697 06:05:04 INFO - PROCESS | 9039 | __metrics 06:05:04 INFO - PROCESS | 9039 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:04 INFO - PROCESS | 9039 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:05 INFO - TEST-INFO | 9039: exit 0 06:05:05 INFO - Browser initialized. 06:05:05 INFO - Running cycle 1/1 for v8_7 test... 06:05:05 INFO - TEST-INFO | started process 9124 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl02IGs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:17 INFO - PROCESS | 9124 | RSS: Main: 149794816 06:05:17 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | Cycle 1(1): loaded http://localhost:59731/tests/v8_7/run.html (next: http://localhost:59731/tests/v8_7/run.html) 06:05:38 INFO - PROCESS | 9124 | RSS: Main: 577224704 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | __start_tp_report 06:05:38 INFO - PROCESS | 9124 | _x_x_mozilla_page_load 06:05:38 INFO - PROCESS | 9124 | _x_x_mozilla_page_load_details 06:05:38 INFO - PROCESS | 9124 | |i|pagename|runs| 06:05:38 INFO - PROCESS | 9124 | |0;Richards;167.3080140538732 06:05:38 INFO - PROCESS | 9124 | |1;DeltaBlue;190.69412662090008 06:05:38 INFO - PROCESS | 9124 | |2;Encrypt;279.72027972027973 06:05:38 INFO - PROCESS | 9124 | |3;Decrypt;5263.1578947368425 06:05:38 INFO - PROCESS | 9124 | |4;RayTrace;1996.007984031936 06:05:38 INFO - PROCESS | 9124 | |5;Earley;780.0312012480499 06:05:38 INFO - PROCESS | 9124 | |6;Boyer;12195.121951219513 06:05:38 INFO - PROCESS | 9124 | |7;RegExp;25650 06:05:38 INFO - PROCESS | 9124 | |8;Splay;625.3908692933084 06:05:38 INFO - PROCESS | 9124 | |9;NavierStokes;4835.748792270531 06:05:38 INFO - PROCESS | 9124 | __end_tp_report 06:05:38 INFO - PROCESS | 9124 | __startTimestamp1451484338926__endTimestamp 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | ------- Summary: start ------- 06:05:38 INFO - PROCESS | 9124 | Number of tests: 10 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 167.3 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 190.7 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 279.7 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 5263.2 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#4] RayTrace Cycles:1 Average:1996.01 Median:1996.01 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 1996.0 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 780.0 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 12195.1 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#7] RegExp Cycles:1 Average:25650.00 Median:25650.00 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 25650.0 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#8] Splay Cycles:1 Average:625.39 Median:625.39 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 625.4 06:05:38 INFO - PROCESS | 9124 | 06:05:38 INFO - PROCESS | 9124 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:05:38 INFO - PROCESS | 9124 | Values: 4835.7 06:05:38 INFO - PROCESS | 9124 | -------- Summary: end -------- 06:05:38 INFO - PROCESS | 9124 | 06:05:39 INFO - TEST-INFO | 9124: exit 0 06:05:39 INFO - TEST-OK | v8_7 | took 39510ms 06:05:39 INFO - SUITE-END | took 1211s 06:05:39 INFO - Completed test suite (00:20:11) 06:05:39 INFO - Working with test: dromaeo_css 06:05:39 INFO - Generating results file: dromaeo_css 06:05:39 INFO - Working with test: kraken 06:05:39 INFO - Generating results file: kraken 06:05:39 INFO - javascript benchmark 06:05:39 INFO - Working with test: v8_7 06:05:39 INFO - Generating results file: v8_7 06:05:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:05:40 INFO - process_Request line: dromaeo_css 6898.52 graph.html#tests=[[72,1,35]] 06:05:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:40 INFO - process_Request line: kraken 1508.90 graph.html#tests=[[232,1,35]] 06:05:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:05:40 INFO - process_Request line: v8_7 19742.33 graph.html#tests=[[230,1,35]] 06:05:40 INFO - RETURN: dromaeo_css: 6898.52 06:05:40 INFO - RETURN: kraken: 1508.90 06:05:40 INFO - RETURN: v8_7: 19742.33 06:05:40 INFO - javascript benchmark 06:05:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3153.495440729483, 3197.0249074032413, 3256.218507558185, 3257.136858732435, 3282.8522716477764, 5225.581953443725, 5304.814331498398, 5353.250544923709, 5397.271368365269, 5451.727413629323, 5340.145576707728, 5358.196270559418, 5367.409584945653, 5403.459654034595, 5444.210589464526, 4846.757662116897, 4918.2376731606655, 4932.950670493285, 4977.825776097838, 4980.178270585349, 4881.4874438184015, 4960.578350840165, 4962.851114466572, 4984.675996060245, 5060.190369540875, 4816.397950256218, 5005.424376196747, 5012.72430016349, 5080.517350851663, 5117.769700363474, 4853.708777473363, 4942.258661200813, 5007.12375334315, 5014.548690617826, 5024.84925452237, 4907.828226012108, 4908.607311415114, 4922.310876477296, 4927.802887884516, 4951.158303088448, 5123.692578445268, 5221.0, 5248.921266181011, 5249.737513124367, 5261.5264626183825, 5524.254225679562, 5679.204911312419, 5688.146777983295, 5690.943090569124, 5723.570732195102, 5834.183214349994, 5842.912356314659, 5854.47309742121, 5856.824295271149, 5859.619124756877, 5435.130379139358, 5445.292112025451, 5447.0, 5447.373552041566, 5453.863653408617, 5692.23154874095, 5775.364709881909, 5798.246227990334, 5800.59395842287, 5890.263717035371, 5620.4660557247, 5624.353199382042, 5626.381098079208, 5631.493165615032, 5675.290588676416, 5641.80253691127, 5696.0, 5705.0, 5707.286589176353, 5722.828315150552, 5546.389897111315, 5613.7193140342815, 5661.264035675335, 5700.401457846866, 5710.3433105193435, 5672.688002159838, 5716.685582292931, 5719.199312096227, 5722.313322401255, 5728.48443640066, 4376.40918476008, 4426.336049592587, 4428.579284967923, 4438.378626992224, 4474.239379305526, 3911.1395492992065, 3973.046468847456, 3980.5621381647998, 3991.1020020495157, 4013.0368711509614, 5367.570594352443, 5368.141097424472, 5370.543503802221, 5371.62398632092, 5375.4624537546715, 5579.9163012554845, 5684.8294551163535, 5846.269216347957, 5850.678212698343, 5853.443922827325, 5177.352830896138, 5258.7370631468275, 5308.867278318073, 5333.946660533423, 5382.515573598395, 4910.484399138039, 4914.533119353656, 4914.557689807934, 4918.434380046269, 4957.851264462072, 5672.347680016768, 5762.078067509178, 5764.308283006066, 5776.104703770922, 5784.82645520635, 5545.750441230235, 5713.371529131709, 5818.592698511064, 5828.417158284137, 5830.5627077968475, 5854.765809367577, 5862.7654893805475, 5864.384239654775, 5864.560157988082, 5870.735816888165, 5748.655080695172, 5752.741126649227, 5755.539556835527, 5759.625624334405, 5772.336181339199, 5647.265855438766, 5737.454941780524, 5752.0, 5752.68360240174, 5840.883182336244, 5590.692511911884, 5619.522340601095, 5633.802816901389, 5636.21093046982, 5636.689982051026, 5581.469760372758, 5610.270664813548, 5637.126245431965, 5637.2107904894165, 5642.802501912413, 5394.217838413487, 5447.645903016291, 5511.751971161227, 5514.558835293086, 5577.135543990688, 5510.256115424527, 5539.113741801292, 5539.556835453073, 5543.3902270751, 5577.6653400796085, 5431.913617276639, 5440.700761458158, 5444.401115877329, 5445.0, 5458.754356053908], "unit": "score", "name": "dojo.html", "value": 5290.43371150915}, {"lowerIsBetter": false, "replicates": [510.8084468324376, 549.9715531955244, 554.9084401073823, 563.540714317831, 569.6496654557446, 28283.434331313387, 28816.13551593453, 28854.0, 28857.711422885764, 28877.27806804831, 28893.0, 29370.0, 36991.44512832303, 37582.0, 37686.811565942204, 8477.618507167177, 8588.312934965219, 8631.136886311382, 8635.43869648474, 8639.222469977702, 7588.848223035536, 8420.24217820396, 8537.10360412157, 8547.401681882271, 8553.914460855405, 7523.548587084765, 10112.191024718006, 10247.282690211689, 10281.177505799555, 10305.948470257637, 9926.950365248164, 10029.749256268578, 10030.648927287582, 10034.69895903124, 10060.195184385231, 7618.923810761877, 7764.456488045839, 7776.066871975343, 9810.362326448758, 9976.251781116445, 39966.80016599898, 40987.7950610245, 41045.79477102625, 41046.1790764183, 41061.178776424305, 3338.88313909012, 3384.9323013539592, 3498.702610278129, 3516.1033936346325, 3861.6331448512346, 26145.346366340804, 26222.0, 26627.73372266272, 26812.329691757666, 26911.0, 3413.607435144965, 3426.1777173478436, 3455.706264967481, 3513.9824300878586, 3555.5733312002467, 223842.0, 227247.0, 228377.0, 228637.0, 229735.0, 55080.0, 55479.0, 55492.72253638787, 55506.16740748892, 55539.0, 60004.0, 60084.39915600788, 60228.698856505434, 60283.0, 60380.3771773695, 15896.920515397349, 16055.839441605667, 16161.515154545383, 16223.756643650355, 16233.67532649364, 12103.757924841453, 12256.693582660326, 12257.26456412618, 12260.32568208757, 12262.386880655931, 19477.415677529698, 20197.899010504854, 20210.494737631678, 20216.292429764886, 20237.190512379635, 7524.209957954336, 7593.164751877289, 7656.3874890008665, 7741.61291935401, 7802.531848089133, 880.366136381804, 918.2699753695695, 940.9670661526951, 972.6206779356057, 1057.6721216422934, 25166.874165629055, 25440.872795635903, 27999.860000699868, 29139.0, 29238.56142157869, 978.6868202175378, 990.5938565188238, 1053.3100818963592, 1090.7763908398758, 1093.3603841752504, 13319.334033298297, 13375.0, 13433.126846754929, 13488.258145802076, 13564.321783910766, 327027.0, 327901.0, 328076.0, 328425.0, 328455.51217122335, 44035.0, 45034.32448513275, 49856.750716246184, 50507.0, 50611.746941265796, 1342.5166939901628, 1352.2359866675297, 1355.6678613739698, 1357.5248662968079, 1360.3266383140408, 24981.125660601792, 25382.61926071147, 25937.6109358356, 26124.34689132787, 30436.543451847796, 40159.1968160641, 40188.397174043, 40920.1815963685, 41004.0, 41134.1773164541, 236948.0, 238364.0, 238714.0, 238828.0, 239792.0, 30117.849410752806, 30440.543391848696, 30454.54318185185, 30994.225144371572, 31155.0, 38291.425628615034, 38436.42345364878, 43239.56760432355, 43309.0, 44323.556764431945, 35800.46299305565, 35872.0, 36735.63264367429, 37062.814685926394, 37078.6292137086, 34802.82598586991, 35145.89848508173, 35512.0, 35803.28393432169, 36057.27885442224, 35233.1191720209, 35467.645323546436, 35676.82161589176, 36172.63827361798, 36677.63322366849, 27780.722192778623, 29846.701532984393, 30028.249293766956, 30147.698523015366, 30205.546916795825, 23140.652890206322, 23837.165699200446, 23910.28269151928, 23982.52034959326, 24044.39889002789], "unit": "score", "name": "ext.html", "value": 17686.597039067972}, {"lowerIsBetter": false, "replicates": [358.63598447575714, 366.3936185612811, 368.37560335231774, 369.796611863475, 369.80954808273736, 13926.303684815744, 14035.859641403584, 16106.114163721006, 16436.424725134624, 16983.320667173313, 15717.764233536505, 15757.684846303067, 15917.204139793022, 16388.83611163888, 16436.67126657466, 5309.654872433289, 5430.294061771984, 5433.565314774828, 5436.700981446019, 5441.5102640762325, 4049.8380064797375, 4100.466939297887, 5387.057264978633, 5428.294321738169, 5842.298924129089, 5915.526757859382, 5945.554083443737, 5975.282966044059, 5976.701164941757, 5980.671063091529, 5762.279715035621, 5884.411558844081, 5927.2590926134235, 5933.970330148343, 5942.732577034044, 5209.557187639055, 5251.501107394792, 5253.343332083489, 5257.553107985826, 5259.184826351921, 18676.719849202273, 20366.389008329774, 20409.4897627559, 20608.793912060988, 21117.47206319839, 2319.1187348807343, 2369.2655276864225, 2397.6643269942224, 2401.3756423329887, 2457.3242358351417, 9083.409578377385, 9323.300752443525, 9380.202682771973, 9453.858192127123, 9490.335676502647, 1790.2838864454193, 1807.159670753093, 1843.7050071988551, 1845.4002449204063, 1885.4626431466966, 56967.43032569663, 58798.70600647012, 58812.0, 59077.99999999957, 59549.70225148847, 10067.848982265272, 10085.546150423248, 10117.645882394081, 10129.645462408927, 10160.08559229658, 13287.867121328663, 13303.600891973256, 13322.267275299952, 13332.066755327229, 13350.799738003938, 7765.495242809199, 7829.982102326775, 7849.0, 7882.802929926797, 7894.64474098667, 7237.421006319481, 7338.4496162788, 7342.0, 7354.0, 7565.335626162236, 4296.806643701041, 4334.674899382559, 4367.934480982788, 4404.405405270311, 4407.691461597721, 1768.7789026371704, 1784.4111443223705, 1816.845568126724, 1850.1406086882866, 1852.8054554271878, 912.5163663258484, 936.828963795256, 948.7628092976756, 991.3011327014437, 1005.8038682456851, 16767.664646707242, 17149.314027439013, 17182.22679979379, 17318.480445586654, 17625.559361016076, 826.3969094746899, 900.6712549919232, 933.09955892564, 933.118203297877, 1016.6441745389054, 6651.733930642817, 9106.908930910738, 9177.357584968988, 9209.723708288628, 9293.0, 405801.0, 408457.0, 409292.0, 579869.0, 589058.0, 39508.802455987534, 60430.0, 66292.668536657, 69738.65130674314, 70935.64532177306, 1165.516310731037, 1165.5920427850185, 1174.9060075193963, 1186.6024881664566, 1196.0132890365483, 15707.0, 15827.36690532412, 15924.601884952968, 15988.600284992503, 16281.267342969359, 35350.82324588361, 36885.81557092197, 36948.0, 36985.0, 37401.62598373982, 46349.53650463587, 47020.7648961753, 48753.2687009688, 48863.0, 49337.75331123322, 9145.77135571616, 9485.098915603006, 9488.810223795623, 9558.139767420966, 9563.474008929576, 11206.38364889939, 11306.830397544209, 11387.54449822031, 11681.88318116808, 16462.835371646608, 13491.0, 13710.862891370958, 14184.0, 14306.284685765462, 14309.785353219502, 13714.382852771849, 13767.862321376659, 13882.0, 13892.23592702411, 14217.218053007184, 14009.08940918837, 14044.508442204473, 14216.21810800416, 14417.423303068179, 14726.484573039892, 9374.203192728695, 9679.612815487302, 9718.951405242928, 9895.406275623485, 9900.702978910644, 10458.215633827645, 11883.82174267404, 14066.78899816524, 14419.495317663832, 15171.393144274105], "unit": "score", "name": "jquery.html", "value": 8722.440012198394}, {"lowerIsBetter": false, "replicates": [1337.1509091726762, 1496.461273941381, 1522.535626633877, 1699.1419333236722, 1841.0242571437134, 6764.32356764324, 7311.3785328247095, 7402.259774022602, 7410.740624078158, 7413.147488038877, 7274.0, 7482.4762266641355, 7484.476086673922, 7493.887591686115, 7496.062992125984, 2045.8772473651554, 2078.8025137611903, 2079.4177630263475, 2277.87471689057, 2312.167619656922, 2293.1515339324474, 2321.292005938188, 2326.5463234669246, 2326.8836558172106, 2327.3367090379247, 2272.1479445208047, 2294.827887908405, 2310.2260742651147, 2325.6278995360744, 2330.883455827202, 2281.703378560793, 2296.0930432479163, 2325.5232677301196, 2328.1269523928527, 2338.1232037985756, 2308.826837987158, 2337.922477839062, 2344.882755862217, 2345.1791872844537, 2358.0332063853907, 7574.734884279023, 7669.271419215165, 7676.577788221645, 7679.539227646359, 7699.5380277182985, 4600.17196904557, 4715.1512727709, 4719.858404247878, 4721.551452611996, 4725.40932383452, 3178.1895616617844, 3188.1232661018175, 3196.7282780963646, 3254.902352929416, 3306.93386132276, 966.2173639352147, 973.090160699748, 1024.1243736605245, 1028.7273872423739, 1058.6453538064682, 10705.785884282348, 10706.571737130505, 10719.78560428787, 10725.678229653124, 10729.624463143753, 4194.769287689206, 4201.369794530845, 4278.0, 4315.8489452869, 4327.82688692455, 8759.386842920934, 8804.075572064969, 8843.380963332505, 8849.867251991225, 8872.157145071207, 4725.1730947084125, 4729.361536192639, 4732.716037037789, 4735.763211839463, 4748.477667456577, 4313.396124542566, 4347.5217726050105, 4356.150550642595, 4371.431713877176, 4378.64970802335, 3442.0534353053113, 3470.6876381125317, 3630.9636903630626, 3683.852645894188, 3772.396416573335, 1188.6849984754047, 1191.2197510630551, 1196.9461374238006, 1207.0223119273242, 1213.660175150959, 992.1913640383065, 1008.6520150548049, 1052.3002203534718, 1052.7315534538798, 1087.3910610058392, 7020.929790702027, 7060.7528736495005, 7072.267294512877, 7073.434125269966, 7089.964550177319, 1102.7573933734566, 1110.35044498969, 1131.8698349689892, 1138.282881784487, 1165.7085728567858, 5658.377578466366, 5773.711314434261, 5786.392428794916, 5787.768489260382, 5793.710314484343, 8884.156005179497, 9344.34589578723, 9353.251739860794, 9446.952765236267, 9460.0, 9316.068393160629, 9346.0653934606, 9421.0, 9423.717288481357, 9426.95286523563, 7125.073740413816, 7229.602371869492, 7247.4926755126635, 7286.052813134259, 7289.927100729031, 6985.0, 7019.929800702132, 7023.789286321418, 7036.964815176096, 7040.190378106583, 7800.531968081933, 7838.098618658927, 7983.0, 8086.676532938616, 8087.514749115072, 8161.551114688749, 8164.428490005643, 8172.632231549714, 8291.295239904675, 8295.087540370676, 6779.661016949231, 6941.2364639888565, 6959.826004349932, 6971.65141742921, 6973.12835895513, 6598.472122230306, 6686.465082793462, 7093.077899872984, 7241.927580724126, 7310.195878453473, 6833.077534532973, 6881.827954301182, 6922.169339679271, 6977.406920411619, 7010.123734533184, 6721.93278067213, 6735.191776986793, 6828.7268509259075, 6851.862962740617, 6896.310368963063, 6974.442044636518, 7006.929930700628, 7023.68393422287, 7034.753783617549, 7057.929420705727, 6302.149209856794, 6318.526110541636, 6363.172787537591, 6367.61794292344, 6410.583312084699, 6481.0, 6505.349465053457, 6541.411272985454, 6555.967220163869, 6580.276169621242], "unit": "score", "name": "mootools.html", "value": 4442.87508054393}, {"lowerIsBetter": false, "replicates": [338.0770496544434, 338.41116457364177, 344.4677972532437, 344.70527698817517, 351.978881267124, 5873.236479257701, 5941.5246780257585, 6012.699365031747, 6024.0963855421705, 6030.608010479321, 5782.045962416196, 5920.792772252972, 5923.496502797257, 5938.346781854003, 5954.851128721773, 4598.149342371656, 4601.976990115061, 4610.400647915766, 4612.607928326096, 4615.630749540045, 4401.955980440202, 4459.197344478009, 4503.617192538622, 4573.382593349905, 4617.46899106602, 4537.546245375453, 4537.795799189028, 4557.065801510682, 4567.429071366079, 4578.198815207342, 4570.880134367101, 4577.427821522327, 4579.015511664975, 4579.198640237978, 4581.496035436099, 4017.9397309040387, 4026.979865100656, 4030.7581545107387, 4036.939445908284, 4040.5353384360587, 5567.916481252784, 5664.2636457260705, 5674.092145256739, 5683.090705487102, 5702.885942281131, 5276.683398996072, 5288.1538953767595, 5289.418164001957, 5293.444188360205, 5294.417614062489, 6063.575549711522, 6340.112384266206, 6344.904826427561, 6352.301246862841, 6356.586821856611, 4233.534311225793, 4313.97843010783, 4336.02439451121, 4343.2182207202695, 4349.499807522144, 6497.18785151856, 6580.407763301278, 6590.472762179063, 6601.009848522712, 6601.63690996995, 4506.1213063452315, 4508.932366014513, 4516.638668906479, 4517.932231016537, 4524.389207456951, 4461.598456138963, 4567.200739870509, 4575.519570445122, 4578.931316030262, 4582.427196600425, 5265.131253343232, 5269.367675878919, 5269.4730526947, 5273.156294992783, 5275.261463395128, 6342.429181373698, 6347.0, 6350.809475715643, 6353.618782873043, 6357.682115894187, 1588.626672731907, 1609.2919115589104, 1622.594351412147, 1622.6592415592622, 1624.3746157729122, 1067.2475904487317, 1067.6903697927514, 1076.7469644633504, 1077.671310250381, 1110.123002827757, 5945.137954996501, 5946.226990491295, 5948.315943666534, 5948.940510594839, 5954.404559544011, 6557.5081868860025, 6567.4417674497245, 6578.473722102221, 6581.736730530821, 6591.011348297794, 5848.619839710405, 5961.135635332853, 5971.343152253248, 5971.671558064261, 5975.641461512237, 3539.5752509698486, 3557.768745031565, 3563.572371315407, 3566.5006899034156, 3567.6432356764635, 6594.637294948728, 6599.637019963852, 6602.834929126714, 6607.537472376984, 6613.239477460057, 6709.127813384229, 6743.696533655997, 6754.223264324567, 6756.324367563303, 6759.662016899136, 6468.223813142359, 6625.271220165778, 6632.2704502504685, 6643.534952553275, 6697.09589205451, 6334.90497642545, 6482.935170648233, 6662.833429164116, 6665.566738162004, 6670.899936500859, 6370.55406121567, 6515.381038801306, 6530.379613936669, 6561.278259391368, 6568.244651865097, 6614.371634694697, 6615.17310336208, 6615.536912416084, 6624.403803657694, 6633.900491492535, 4379.321205213197, 4502.189605870974, 4527.909441811211, 4529.456465224194, 4532.342810292555, 6600.570962887397, 6612.966935165294, 6620.8344791380605, 6625.271220165681, 6629.270780214269, 6432.388923052303, 6435.871282574416, 6436.806895793134, 6440.935590644033, 6444.871102578016, 6270.435660790551, 6423.935760642521, 6428.839279018062, 6434.420902118832, 6435.646039467874, 6298.0867774171575, 6299.08663243818, 6301.180846489927, 6303.9684801575695, 6304.3380445054445, 6439.484841212786, 6444.0, 6444.581102228528, 6445.935540644721, 6449.226092868698, 6133.50931925436, 6285.59143655661, 6292.402221788922, 6295.370462953668, 6317.0], "unit": "score", "name": "prototype.html", "value": 4781.967793870715}, {"lowerIsBetter": false, "replicates": [804.6379129391773, 807.3178164451036, 811.5212024905309, 815.4658698552447, 827.9130691277412, 13466.865331346684, 13517.864821351783, 13705.794413083811, 13785.862141378584, 13805.654858628539, 13542.39059242334, 13590.864091359084, 13647.317634118279, 13657.931710341434, 13694.863051369482, 697.5221972948522, 705.7071315404102, 830.4311546590575, 833.8290650416665, 854.8888644476209, 848.9363297752662, 858.6179150278128, 863.7236084452977, 865.6277800545763, 866.0430224601819, 892.3708785306344, 909.9863502047441, 911.2618778789168, 911.4485736129612, 911.6034524981621, 725.0393228971608, 734.0787311923528, 878.4597472554365, 901.7204666553324, 904.6788390121544, 651.2315467748056, 654.3979538824293, 661.8246164766341, 661.9702113404908, 663.187595195886, 13125.409356578977, 13237.536686216032, 13259.27074010929, 13264.801027984588, 13296.069275150743, 11658.242214256046, 11686.532538698442, 11904.880951190551, 11905.821412678817, 11965.700857478545, 10564.366138031666, 10627.78744425115, 10657.893421065768, 10680.78638427235, 10717.35695858251, 3599.3341231872187, 3678.889633311005, 3684.8157592120556, 3692.649198326155, 3772.981135094307, 44667.0, 45042.54957450416, 45244.0, 45261.0, 45650.77174614139, 10038.347507411994, 10215.540300686487, 10346.793064138676, 10348.948255258827, 10386.11718003963, 17130.828691713174, 17262.05058721757, 17269.222884970208, 17306.307747689953, 17312.40313952917, 7332.340089391981, 7475.0, 7516.210797866254, 7594.582297973665, 7607.65765540552, 4066.755994640331, 4201.327787553977, 4255.69888848126, 4355.956440435555, 4372.1692878353015, 3080.9537856932166, 3114.377124575094, 3116.158637167952, 3116.407882502317, 3116.9064928052194, 567.7473524281655, 578.2251782611321, 589.7699897040158, 592.9407059294036, 599.5862854630291, 634.2135751667898, 663.8904580744123, 672.7174586673609, 673.8618583190434, 691.094665987558, 8883.111688831064, 9036.683716070038, 9191.31065170115, 9243.953780231055, 9373.718788436357, 622.953278504114, 675.3955210087042, 679.4734081087098, 716.7634680555404, 727.0548287226584, 3682.9447558286647, 3719.3119272934596, 4008.0581063450068, 4049.9797501012895, 4080.591940805955, 53339.46660533422, 55196.448035519934, 55269.17096243559, 55318.44681553133, 55463.0, 45550.54449455463, 45656.77171614187, 45882.54117458849, 49818.501814981384, 50299.74850125799, 44379.334309985374, 44955.55044449579, 45038.774806126414, 45373.09253814905, 45439.046461979866, 7874.72438464651, 8001.0, 8087.514749115072, 8104.149064348158, 8273.214044665747, 32568.67431325751, 32699.34601308008, 32922.0, 33695.663043369255, 33872.830635846665, 38519.42220866633, 39599.2080158401, 43195.56804431915, 43247.0, 43780.56219437765, 9946.154576861049, 10084.495775211064, 10138.543765530716, 10334.948325258325, 10441.0, 11600.129990250596, 11745.706357341134, 11833.408329583659, 11836.112291577994, 12238.204516706386, 10327.948360258151, 10360.067593916583, 10585.9470702646, 10933.781324373309, 11045.28205666629, 10189.694309170736, 10337.586496540054, 10522.894771052192, 10611.09805666527, 10733.838992414963, 10088.142507886618, 10375.221858360805, 10493.685189444328, 10579.36523808574, 10599.417032063002, 9312.243118694732, 9427.15155635996, 9429.858552121586, 9507.286953478655, 9668.0, 8360.707375241838, 8569.843031552284, 8804.47173169612, 8823.426477278956, 9712.854307185256], "unit": "score", "name": "yui.html", "value": 6215.16458246399}], "name": "dromaeo_css", "value": 6898.516055563057}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 104.0, 111.0, 111.0, 110.0, 102.0, 110.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 149.0, 159.0, 126.0, 153.0, 158.0, 130.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 162.0, 163.0, 163.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 79.0, 99.0, 70.0, 72.0, 75.0, 98.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [97.0, 103.0, 140.0, 96.0, 96.0, 96.0, 149.0, 96.0, 97.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 60.0, 57.0, 58.0, 57.0, 56.0, 68.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 70.0, 69.0, 70.0, 69.0, 68.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 86.0, 86.0, 89.0, 86.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [128.0, 117.0, 116.0, 131.0, 115.0, 129.0, 115.0, 117.0, 118.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [142.0, 151.0, 151.0, 150.0, 154.0, 141.0, 150.0, 151.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 72.0, 69.0, 67.0, 72.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1508.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1996.007984031936], "unit": "score", "name": "RayTrace", "value": 370.73448899999994}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25650.0], "unit": "score", "name": "RegExp", "value": 35.515984405458106}, {"lowerIsBetter": false, "replicates": [625.3908692933084], "unit": "score", "name": "Splay", "value": 130.30410899999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19742.330042078476}]} 06:05:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19742.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1508.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6898.52"}}} 06:05:40 INFO - Return code: 0 06:05:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:05:40 INFO - # TBPL SUCCESS # 06:05:40 INFO - Running post-action listener: _resource_record_post_action 06:05:40 INFO - Running post-run listener: _resource_record_post_run 06:05:41 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 543768576; Read time: 160; Write time: 426108 06:05:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235520000; Read time: 0; Write time: 250060 06:05:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 308248576; Read time: 160; Write time: 176048 06:05:41 INFO - Running post-run listener: _upload_blobber_files 06:05:41 INFO - Blob upload gear active. 06:05:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:05:41 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 06:05:41 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'] 06:05:41 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 06:05:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:42 INFO - (blobuploader) - INFO - Done attempting. 06:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:43 INFO - (blobuploader) - INFO - Done attempting. 06:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 06:05:43 INFO - Return code: 0 06:05:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:05:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a93d35e28c9a79e41ae3d8453511422fa304a96da5f9a7b1602eaace6c20039cf747a2cce5453173f7887d5ac33e5da736fc04808375b15b0e609e21c1aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/209ac03694f9f618117931da10fe1514fc080706f6998d6b7875e7096a574fa46245f619ddcfd6d678fb43af38328ff6120978c050a3386ba4916fe14fc0c3c0"} 06:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:05:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:05:43 INFO - Contents: 06:05:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01a93d35e28c9a79e41ae3d8453511422fa304a96da5f9a7b1602eaace6c20039cf747a2cce5453173f7887d5ac33e5da736fc04808375b15b0e609e21c1aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/209ac03694f9f618117931da10fe1514fc080706f6998d6b7875e7096a574fa46245f619ddcfd6d678fb43af38328ff6120978c050a3386ba4916fe14fc0c3c0"} 06:05:43 INFO - Copying logs to upload dir... 06:05:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.617419 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 06:05:43.100298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 06:05:43.107535) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 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/01a93d35e28c9a79e41ae3d8453511422fa304a96da5f9a7b1602eaace6c20039cf747a2cce5453173f7887d5ac33e5da736fc04808375b15b0e609e21c1aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/209ac03694f9f618117931da10fe1514fc080706f6998d6b7875e7096a574fa46245f619ddcfd6d678fb43af38328ff6120978c050a3386ba4916fe14fc0c3c0"} build_url:https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009866 build_url: 'https://queue.taskcluster.net/v1/task/FgHZZPdeSXy9kBLmrdH0cw/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/01a93d35e28c9a79e41ae3d8453511422fa304a96da5f9a7b1602eaace6c20039cf747a2cce5453173f7887d5ac33e5da736fc04808375b15b0e609e21c1aa13", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/209ac03694f9f618117931da10fe1514fc080706f6998d6b7875e7096a574fa46245f619ddcfd6d678fb43af38328ff6120978c050a3386ba4916fe14fc0c3c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 06:05:43.136286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 06:05:43.136736) ========= 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=61fa6ed41387771909ec0f71000001b3-1451481737.296500-81051489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 06:05:43.187958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 06:05:43.191393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 06:05:43.191699) ========= ========= Total master_lag: 0.67 =========