builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1451000664.77 results: success (0) buildid: 20151224133004 builduid: a83994666f8c42b6a0a3b27c88a89f05 revision: fedf404c32d9759b27e8493dc03413ed37bd1224 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.768566) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.769089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.769406) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.826938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.827345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.915869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.916170) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004699 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.972361) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.972700) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.973092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:24.973458) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 15: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2015-12-24 15:44:25 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.108730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.109062) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019362 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.159398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:25.159740) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fedf404c32d9759b27e8493dc03413ed37bd1224 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fedf404c32d9759b27e8493dc03413ed37bd1224 --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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 15:44:25,864 truncating revision to first 12 chars 2015-12-24 15:44:25,864 Setting DEBUG logging. 2015-12-24 15:44:25,864 attempt 1/10 2015-12-24 15:44:25,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fedf404c32d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 15:44:26,566 unpacking tar archive at: mozilla-inbound-fedf404c32d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:26.146353) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:26.146703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:26.191063) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:26.191361) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 15:44:26.191794) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-24 15:44:26.192141) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:44:26 INFO - MultiFileLogger online at 20151224 15:44:26 in /builds/slave/test-pgo 15:44:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:44:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:44:26 INFO - {'append_to_log': False, 15:44:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:44:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:44:26 INFO - 'branch': 'Mozilla-Inbound', 15:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:26 INFO - 'config_files': ('talos/linux_config.py',), 15:44:26 INFO - 'default_actions': ('clobber', 15:44:26 INFO - 'read-buildbot-config', 15:44:26 INFO - 'download-and-extract', 15:44:26 INFO - 'populate-webroot', 15:44:26 INFO - 'create-virtualenv', 15:44:26 INFO - 'install', 15:44:26 INFO - 'run-tests'), 15:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:26 INFO - 'download_minidump_stackwalk': True, 15:44:26 INFO - 'download_symbols': 'ondemand', 15:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:26 INFO - 'installer_path': 'installer.exe', 15:44:26 INFO - 'log_level': 'info', 15:44:26 INFO - 'log_name': 'talos', 15:44:26 INFO - 'log_to_console': True, 15:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:44:26 INFO - 'opt_config_files': (), 15:44:26 INFO - 'pip_index': False, 15:44:26 INFO - 'sps_profile': False, 15:44:26 INFO - 'sps_profile_interval': 0, 15:44:26 INFO - 'suite': 'dromaeojs-e10s', 15:44:26 INFO - 'system_bits': '64', 15:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:26 INFO - 'title': 'talos-linux64-ix-045', 15:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:26 INFO - 'use_talos_json': True, 15:44:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:26 INFO - 'work_dir': 'build'} 15:44:26 INFO - ##### 15:44:26 INFO - ##### Running clobber step. 15:44:26 INFO - ##### 15:44:26 INFO - Running pre-action listener: _resource_record_pre_action 15:44:26 INFO - Running main action method: clobber 15:44:26 INFO - rmtree: /builds/slave/test-pgo/build 15:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:44:27 INFO - Running post-action listener: _resource_record_post_action 15:44:27 INFO - ##### 15:44:27 INFO - ##### Running read-buildbot-config step. 15:44:27 INFO - ##### 15:44:27 INFO - Running pre-action listener: _resource_record_pre_action 15:44:27 INFO - Running main action method: read_buildbot_config 15:44:27 INFO - Using buildbot properties: 15:44:27 INFO - { 15:44:27 INFO - "project": "", 15:44:27 INFO - "product": "firefox", 15:44:27 INFO - "script_repo_revision": "production", 15:44:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:44:27 INFO - "repository": "", 15:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:44:27 INFO - "buildid": "20151224133004", 15:44:27 INFO - "pgo_build": "True", 15:44:27 INFO - "basedir": "/builds/slave/test-pgo", 15:44:27 INFO - "buildnumber": 548, 15:44:27 INFO - "slavename": "talos-linux64-ix-045", 15:44:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:44:27 INFO - "platform": "ubuntu64_hw", 15:44:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:44:27 INFO - "branch": "mozilla-inbound", 15:44:27 INFO - "repo_path": "integration/mozilla-inbound", 15:44:27 INFO - "revision": "fedf404c32d9759b27e8493dc03413ed37bd1224", 15:44:27 INFO - "stage_platform": "linux64-pgo", 15:44:27 INFO - "builduid": "a83994666f8c42b6a0a3b27c88a89f05", 15:44:27 INFO - "slavebuilddir": "test" 15:44:27 INFO - } 15:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:44:27 INFO - Running post-action listener: _resource_record_post_action 15:44:27 INFO - ##### 15:44:27 INFO - ##### Running download-and-extract step. 15:44:27 INFO - ##### 15:44:27 INFO - Running pre-action listener: _resource_record_pre_action 15:44:27 INFO - Running main action method: download_and_extract 15:44:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 15: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')]} 15:44:27 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json 15:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json 15:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:44:33 INFO - Downloaded 1302 bytes. 15:44:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:44:33 INFO - Using the following test package requirements: 15:44:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:44:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'jsshell-linux-x86_64.zip'], 15:44:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:44:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:44:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:44:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:44:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:44:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:33 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:34 INFO - Downloaded 23189967 bytes. 15:44:34 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 15:44:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:34 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 15:44:35 INFO - Return code: 0 15:44:35 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 15:44:35 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')]} 15:44:35 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:42 INFO - Downloaded 23189967 bytes. 15: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 15:44:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15: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 15:44:43 INFO - Return code: 0 15: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')]} 15:44:43 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:44 INFO - Downloaded 11132270 bytes. 15:44:44 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 15:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:44 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 15:44:45 INFO - Return code: 0 15:44:45 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')]} 15:44:45 INFO - https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B2RJVoL2QOifsSkDKWRdlw/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 15:44:46 INFO - Downloaded 54879000 bytes. 15:44:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:46 INFO - mkdir: /builds/slave/test-pgo/properties 15:44:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:44:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:44:46 INFO - Contents: 15:44:46 INFO - build_url:https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:44:46 INFO - Running post-action listener: _resource_record_post_action 15:44:46 INFO - Running post-action listener: set_extra_try_arguments 15:44:46 INFO - ##### 15:44:46 INFO - ##### Running populate-webroot step. 15:44:46 INFO - ##### 15:44:46 INFO - Running pre-action listener: _resource_record_pre_action 15:44:46 INFO - Running main action method: populate_webroot 15:44:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:46 INFO - '--tppagecycles', 15:44:46 INFO - '7'], 15:44:46 INFO - 'tests': ['tsvgm']}}, 15:44:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:44:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:44:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'tests': ['damp', 'tps']}, 15:44:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['damp', 'tps']}, 15:44:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:44:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:46 INFO - 'other': {'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'other_l64': {'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'other_nol64': {'tests': ['a11yr', 15:44:46 INFO - 'ts_paint', 15:44:46 INFO - 'tpaint', 15:44:46 INFO - 'sessionrestore', 15:44:46 INFO - 'sessionrestore_no_auto_restore']}, 15:44:46 INFO - 'svgr': {'tests': ['tsvgx', 15:44:46 INFO - 'tsvgr_opacity', 15:44:46 INFO - 'tart', 15:44:46 INFO - 'tscrollx', 15:44:46 INFO - 'cart']}, 15:44:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['tsvgx', 15:44:46 INFO - 'tsvgr_opacity', 15:44:46 INFO - 'tart', 15:44:46 INFO - 'tscrollx', 15:44:46 INFO - 'cart']}, 15:44:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'tests': ['tp5o']}, 15:44:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'talos_options': ['--e10s'], 15:44:46 INFO - 'tests': ['tp5o']}, 15:44:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'talos_options': ['--xperf_path', 15:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:46 INFO - 'tests': ['tp5n']}, 15:44:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:46 INFO - 'talos_options': ['--e10s', 15:44:46 INFO - '--xperf_path', 15:44:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:46 INFO - 'tests': ['tp5n']}}, 15:44:46 INFO - 'talos.zip': {'path': '', 15:44:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:46 INFO - Running post-action listener: _resource_record_post_action 15:44:46 INFO - ##### 15:44:46 INFO - ##### Running create-virtualenv step. 15:44:46 INFO - ##### 15:44:46 INFO - Running pre-action listener: _resource_record_pre_action 15:44:46 INFO - Running main action method: create_virtualenv 15:44:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:44:46 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 15:44:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:44:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:46 INFO - Using real prefix '/usr' 15:44:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:44:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:49 INFO - Installing pip.................done. 15:44:49 INFO - Return code: 0 15:44:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:44:49 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')]} 15:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:49 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')]} 15:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:49 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:44:49 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 15:44:49 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 15:44:49 INFO - Using env: {'DISPLAY': ':0', 15:44:49 INFO - 'HOME': '/home/cltbld', 15:44:49 INFO - 'LANG': 'en_US.UTF-8', 15:44:49 INFO - 'LANGUAGE': 'en_US:en', 15:44:49 INFO - 'LOGNAME': 'cltbld', 15:44:49 INFO - 'MAIL': '/var/mail/cltbld', 15:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:49 INFO - 'MOZ_NO_REMOTE': '1', 15:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:49 INFO - 'NO_EM_RESTART': '1', 15:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:49 INFO - 'SHELL': '/bin/bash', 15:44:49 INFO - 'SHLVL': '1', 15:44:49 INFO - 'TERM': 'linux', 15:44:49 INFO - 'TMOUT': '86400', 15:44:49 INFO - 'USER': 'cltbld', 15:44:49 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:49 INFO - '_': '/tools/buildbot/bin/python'} 15:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:49 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 15:44:49 INFO - Cleaning up... 15:44:49 INFO - Return code: 0 15:44:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:44:49 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')]} 15:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:49 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')]} 15:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:49 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:44:49 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 15:44:49 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 15:44:49 INFO - Using env: {'DISPLAY': ':0', 15:44:49 INFO - 'HOME': '/home/cltbld', 15:44:49 INFO - 'LANG': 'en_US.UTF-8', 15:44:49 INFO - 'LANGUAGE': 'en_US:en', 15:44:49 INFO - 'LOGNAME': 'cltbld', 15:44:49 INFO - 'MAIL': '/var/mail/cltbld', 15:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:49 INFO - 'MOZ_NO_REMOTE': '1', 15:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:49 INFO - 'NO_EM_RESTART': '1', 15:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:49 INFO - 'SHELL': '/bin/bash', 15:44:49 INFO - 'SHLVL': '1', 15:44:49 INFO - 'TERM': 'linux', 15:44:49 INFO - 'TMOUT': '86400', 15:44:49 INFO - 'USER': 'cltbld', 15:44:49 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:49 INFO - '_': '/tools/buildbot/bin/python'} 15:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:49 INFO - Downloading/unpacking psutil>=0.7.1 15:44:49 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 15:44:49 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 15:44:49 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 15:44:49 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 15:44:49 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 15:44:49 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 15:44:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:44:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:44:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:51 INFO - Installing collected packages: psutil 15:44:51 INFO - Running setup.py install for psutil 15:44:51 INFO - building 'psutil._psutil_linux' extension 15:44:51 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 15:44:51 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 15:44:51 INFO - building 'psutil._psutil_posix' extension 15:44:51 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 15:44:51 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 15:44:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:51 INFO - Successfully installed psutil 15:44:51 INFO - Cleaning up... 15:44:51 INFO - Return code: 0 15:44:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:51 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:44:51 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 15:44:51 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 15:44:51 INFO - Using env: {'DISPLAY': ':0', 15:44:51 INFO - 'HOME': '/home/cltbld', 15:44:51 INFO - 'LANG': 'en_US.UTF-8', 15:44:51 INFO - 'LANGUAGE': 'en_US:en', 15:44:51 INFO - 'LOGNAME': 'cltbld', 15:44:51 INFO - 'MAIL': '/var/mail/cltbld', 15:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:51 INFO - 'MOZ_NO_REMOTE': '1', 15:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:51 INFO - 'NO_EM_RESTART': '1', 15:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:51 INFO - 'SHELL': '/bin/bash', 15:44:51 INFO - 'SHLVL': '1', 15:44:51 INFO - 'TERM': 'linux', 15:44:51 INFO - 'TMOUT': '86400', 15:44:51 INFO - 'USER': 'cltbld', 15:44:51 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:51 INFO - '_': '/tools/buildbot/bin/python'} 15:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:44:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:44:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:44:53 INFO - Installing collected packages: mozsystemmonitor 15:44:53 INFO - Running setup.py install for mozsystemmonitor 15:44:53 INFO - Successfully installed mozsystemmonitor 15:44:53 INFO - Cleaning up... 15:44:53 INFO - Return code: 0 15:44:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15: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')]} 15:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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', '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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15: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 blobuploader==1.2.4 15:44:53 INFO - Using env: {'DISPLAY': ':0', 15:44:53 INFO - 'HOME': '/home/cltbld', 15:44:53 INFO - 'LANG': 'en_US.UTF-8', 15:44:53 INFO - 'LANGUAGE': 'en_US:en', 15:44:53 INFO - 'LOGNAME': 'cltbld', 15:44:53 INFO - 'MAIL': '/var/mail/cltbld', 15:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:53 INFO - 'MOZ_NO_REMOTE': '1', 15:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:53 INFO - 'NO_EM_RESTART': '1', 15:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:53 INFO - 'SHELL': '/bin/bash', 15:44:53 INFO - 'SHLVL': '1', 15:44:53 INFO - 'TERM': 'linux', 15:44:53 INFO - 'TMOUT': '86400', 15:44:53 INFO - 'USER': 'cltbld', 15:44:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:53 INFO - '_': '/tools/buildbot/bin/python'} 15:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:54 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15: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 15: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 15: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 15: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 15: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 15: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 15:44:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:44:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:44:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:56 INFO - Downloading docopt-0.6.1.tar.gz 15:44:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:44:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:56 INFO - Running setup.py install for blobuploader 15:44:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:44:56 INFO - Running setup.py install for requests 15:44:56 INFO - Running setup.py install for docopt 15:44:57 INFO - Successfully installed blobuploader requests docopt 15:44:57 INFO - Cleaning up... 15:44:57 INFO - Return code: 0 15:44:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:57 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:44:57 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 15:44:57 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 15:44:57 INFO - Using env: {'DISPLAY': ':0', 15:44:57 INFO - 'HOME': '/home/cltbld', 15:44:57 INFO - 'LANG': 'en_US.UTF-8', 15:44:57 INFO - 'LANGUAGE': 'en_US:en', 15:44:57 INFO - 'LOGNAME': 'cltbld', 15:44:57 INFO - 'MAIL': '/var/mail/cltbld', 15:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:57 INFO - 'MOZ_NO_REMOTE': '1', 15:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:57 INFO - 'NO_EM_RESTART': '1', 15:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:57 INFO - 'SHELL': '/bin/bash', 15:44:57 INFO - 'SHLVL': '1', 15:44:57 INFO - 'TERM': 'linux', 15:44:57 INFO - 'TMOUT': '86400', 15:44:57 INFO - 'USER': 'cltbld', 15:44:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:57 INFO - '_': '/tools/buildbot/bin/python'} 15:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:57 INFO - Running setup.py (path:/tmp/pip-Bucwtx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:57 INFO - Running setup.py (path:/tmp/pip-byQRCn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:57 INFO - Running setup.py (path:/tmp/pip-CQLLh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:57 INFO - Running setup.py (path:/tmp/pip-wdjUub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:57 INFO - Running setup.py (path:/tmp/pip-vQUQZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:57 INFO - Running setup.py (path:/tmp/pip-6MnoTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:57 INFO - Running setup.py (path:/tmp/pip-Gr6zCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:57 INFO - Running setup.py (path:/tmp/pip-maCDVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:57 INFO - Running setup.py (path:/tmp/pip-uFt599-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:57 INFO - Running setup.py (path:/tmp/pip-33i84z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:58 INFO - Running setup.py (path:/tmp/pip-l_ydBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:58 INFO - Running setup.py (path:/tmp/pip-Q5Iu8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:58 INFO - Running setup.py (path:/tmp/pip-XbOV7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:58 INFO - Running setup.py (path:/tmp/pip-_MNKc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:58 INFO - Running setup.py (path:/tmp/pip-cFnsB2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:58 INFO - Running setup.py (path:/tmp/pip-X_WBBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:58 INFO - Running setup.py (path:/tmp/pip-05cAkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:58 INFO - Running setup.py install for manifestparser 15:44:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:44:58 INFO - Running setup.py install for mozcrash 15:44:58 INFO - Running setup.py install for mozdebug 15:44:58 INFO - Running setup.py install for mozdevice 15:44:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:44:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:44:58 INFO - Running setup.py install for mozfile 15:44:59 INFO - Running setup.py install for mozhttpd 15:44:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for mozinfo 15:44:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for mozInstall 15:44:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for mozleak 15:44:59 INFO - Running setup.py install for mozlog 15:44:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for moznetwork 15:44:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for mozprocess 15:44:59 INFO - Running setup.py install for mozprofile 15:44:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:44:59 INFO - Running setup.py install for mozrunner 15:44:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:45:00 INFO - Running setup.py install for mozscreenshot 15:45:00 INFO - Running setup.py install for moztest 15:45:00 INFO - Running setup.py install for mozversion 15:45:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:45:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:00 INFO - Cleaning up... 15:45:00 INFO - Return code: 0 15:45:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:00 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')]} 15:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:00 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')]} 15:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:00 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:45:00 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 15:45:00 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 15:45:00 INFO - Using env: {'DISPLAY': ':0', 15:45:00 INFO - 'HOME': '/home/cltbld', 15:45:00 INFO - 'LANG': 'en_US.UTF-8', 15:45:00 INFO - 'LANGUAGE': 'en_US:en', 15:45:00 INFO - 'LOGNAME': 'cltbld', 15:45:00 INFO - 'MAIL': '/var/mail/cltbld', 15:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:00 INFO - 'MOZ_NO_REMOTE': '1', 15:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:00 INFO - 'NO_EM_RESTART': '1', 15:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:00 INFO - 'SHELL': '/bin/bash', 15:45:00 INFO - 'SHLVL': '1', 15:45:00 INFO - 'TERM': 'linux', 15:45:00 INFO - 'TMOUT': '86400', 15:45:00 INFO - 'USER': 'cltbld', 15:45:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:00 INFO - '_': '/tools/buildbot/bin/python'} 15:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:00 INFO - Running setup.py (path:/tmp/pip-E6Jk4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:00 INFO - Running setup.py (path:/tmp/pip-htF4e2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:00 INFO - Running setup.py (path:/tmp/pip-C5ehuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:00 INFO - Running setup.py (path:/tmp/pip-gqf29J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:00 INFO - Running setup.py (path:/tmp/pip-fMbzGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:00 INFO - Running setup.py (path:/tmp/pip-yBOrTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:45:00 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)) 15:45:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:00 INFO - Running setup.py (path:/tmp/pip-EIr4_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:01 INFO - Running setup.py (path:/tmp/pip-vf8o82-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:01 INFO - Running setup.py (path:/tmp/pip-lztnpJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:01 INFO - Running setup.py (path:/tmp/pip-Ri2RSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:01 INFO - Running setup.py (path:/tmp/pip-CqcZDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:01 INFO - Running setup.py (path:/tmp/pip-1BLBc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:01 INFO - Running setup.py (path:/tmp/pip-8tex_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:01 INFO - Running setup.py (path:/tmp/pip-jpFeZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:01 INFO - Running setup.py (path:/tmp/pip-jJocl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:01 INFO - Running setup.py (path:/tmp/pip-p7yws7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:45:01 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)) 15:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:01 INFO - Running setup.py (path:/tmp/pip-1wiLg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:45:01 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)) 15:45:01 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)) 15:45:01 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)) 15:45:01 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)) 15:45:01 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)) 15:45:01 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)) 15:45:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:03 INFO - Downloading blessings-1.5.1.tar.gz 15:45:03 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 15:45:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:03 INFO - Installing collected packages: blessings 15:45:03 INFO - Running setup.py install for blessings 15:45:03 INFO - Successfully installed blessings 15:45:03 INFO - Cleaning up... 15:45:03 INFO - Return code: 0 15:45:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:45:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:03 INFO - Reading from file tmpfile_stdout 15:45:03 INFO - Current package versions: 15:45:03 INFO - argparse == 1.2.1 15:45:03 INFO - blessings == 1.5.1 15:45:03 INFO - blobuploader == 1.2.4 15:45:03 INFO - docopt == 0.6.1 15:45:03 INFO - manifestparser == 1.1 15:45:03 INFO - mozInstall == 1.12 15:45:03 INFO - mozcrash == 0.16 15:45:03 INFO - mozdebug == 0.1 15:45:03 INFO - mozdevice == 0.47 15:45:03 INFO - mozfile == 1.2 15:45:03 INFO - mozhttpd == 0.7 15:45:03 INFO - mozinfo == 0.9 15:45:03 INFO - mozleak == 0.1 15:45:03 INFO - mozlog == 3.1 15:45:03 INFO - moznetwork == 0.27 15:45:03 INFO - mozprocess == 0.22 15:45:03 INFO - mozprofile == 0.28 15:45:03 INFO - mozrunner == 6.11 15:45:03 INFO - mozscreenshot == 0.1 15:45:03 INFO - mozsystemmonitor == 0.0 15:45:03 INFO - moztest == 0.7 15:45:03 INFO - mozversion == 1.4 15:45:03 INFO - psutil == 3.1.1 15:45:03 INFO - requests == 1.2.3 15:45:03 INFO - wsgiref == 0.1.2 15:45:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:03 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')]} 15:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:03 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')]} 15:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:03 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:45:03 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 15:45:03 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 15:45:03 INFO - Using env: {'DISPLAY': ':0', 15:45:03 INFO - 'HOME': '/home/cltbld', 15:45:03 INFO - 'LANG': 'en_US.UTF-8', 15:45:03 INFO - 'LANGUAGE': 'en_US:en', 15:45:03 INFO - 'LOGNAME': 'cltbld', 15:45:03 INFO - 'MAIL': '/var/mail/cltbld', 15:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:03 INFO - 'MOZ_NO_REMOTE': '1', 15:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:03 INFO - 'NO_EM_RESTART': '1', 15:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:03 INFO - 'SHELL': '/bin/bash', 15:45:03 INFO - 'SHLVL': '1', 15:45:03 INFO - 'TERM': 'linux', 15:45:03 INFO - 'TMOUT': '86400', 15:45:03 INFO - 'USER': 'cltbld', 15:45:03 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:03 INFO - '_': '/tools/buildbot/bin/python'} 15:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 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)) 15:45:04 INFO - Cleaning up... 15:45:04 INFO - Return code: 0 15:45:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:45:04 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 15:45:04 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 15:45:04 INFO - Using env: {'DISPLAY': ':0', 15:45:04 INFO - 'HOME': '/home/cltbld', 15:45:04 INFO - 'LANG': 'en_US.UTF-8', 15:45:04 INFO - 'LANGUAGE': 'en_US:en', 15:45:04 INFO - 'LOGNAME': 'cltbld', 15:45:04 INFO - 'MAIL': '/var/mail/cltbld', 15:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:04 INFO - 'MOZ_NO_REMOTE': '1', 15:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:04 INFO - 'NO_EM_RESTART': '1', 15:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:04 INFO - 'SHELL': '/bin/bash', 15:45:04 INFO - 'SHLVL': '1', 15:45:04 INFO - 'TERM': 'linux', 15:45:04 INFO - 'TMOUT': '86400', 15:45:04 INFO - 'USER': 'cltbld', 15:45:04 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:04 INFO - '_': '/tools/buildbot/bin/python'} 15:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:04 INFO - Downloading/unpacking jsonschema 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:06 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 15:45:06 INFO - Downloading/unpacking functools32 (from jsonschema) 15: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 15: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 15: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 15: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 15: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 15: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 15:45:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:06 INFO - warning: no files found matching '*.txt' 15:45:06 INFO - no previously-included directories found matching 'build' 15:45:06 INFO - no previously-included directories found matching 'dist' 15:45:06 INFO - no previously-included directories found matching '.git*' 15:45:06 INFO - Installing collected packages: jsonschema, functools32 15:45:06 INFO - Running setup.py install for functools32 15:45:06 INFO - warning: no files found matching '*.txt' 15:45:06 INFO - no previously-included directories found matching 'build' 15:45:06 INFO - no previously-included directories found matching 'dist' 15:45:06 INFO - no previously-included directories found matching '.git*' 15:45:06 INFO - Successfully installed jsonschema functools32 15:45:06 INFO - Cleaning up... 15:45:06 INFO - Return code: 0 15:45:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:45:06 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')]} 15:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:06 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')]} 15:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:06 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 0x7f8a1a417f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x116c360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, '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-1450999900.95860-285059883', '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 15:45:06 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 15:45:06 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 15:45:06 INFO - Using env: {'DISPLAY': ':0', 15:45:06 INFO - 'HOME': '/home/cltbld', 15:45:06 INFO - 'LANG': 'en_US.UTF-8', 15:45:06 INFO - 'LANGUAGE': 'en_US:en', 15:45:06 INFO - 'LOGNAME': 'cltbld', 15:45:06 INFO - 'MAIL': '/var/mail/cltbld', 15:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:06 INFO - 'MOZ_NO_REMOTE': '1', 15:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:06 INFO - 'NO_EM_RESTART': '1', 15:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:06 INFO - 'SHELL': '/bin/bash', 15:45:06 INFO - 'SHLVL': '1', 15:45:06 INFO - 'TERM': 'linux', 15:45:06 INFO - 'TMOUT': '86400', 15:45:06 INFO - 'USER': 'cltbld', 15:45:06 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:06 INFO - '_': '/tools/buildbot/bin/python'} 15:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:06 INFO - Downloading/unpacking flake8 15: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 15: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 15: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 15: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 15: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 15: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 15:45:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:08 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 15:45:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15: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 15: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 15: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 15: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 15: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 15: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 15:45:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:08 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 15:45:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15: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 15: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 15: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 15: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 15: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 15: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 15:45:08 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 15:45:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15: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 15: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 15: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 15: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 15: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 15: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 15:45:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:45:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:09 INFO - no previously-included directories found matching 'docs/_build' 15:45:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:09 INFO - Running setup.py install for pep8 15:45:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:09 INFO - no previously-included directories found matching 'docs/_build' 15:45:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:45:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:09 INFO - Cleaning up... 15:45:09 INFO - Return code: 0 15:45:09 INFO - Running post-action listener: _resource_record_post_action 15:45:09 INFO - Running post-action listener: _start_resource_monitoring 15:45:09 INFO - Starting resource monitoring. 15:45:09 INFO - ##### 15:45:09 INFO - ##### Running install step. 15:45:09 INFO - ##### 15:45:09 INFO - Running pre-action listener: _resource_record_pre_action 15:45:09 INFO - Running main action method: install 15:45:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:45:09 INFO - Reading from file tmpfile_stdout 15:45:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:45:09 INFO - Reading from file tmpfile_stdout 15:45:09 INFO - Output received: 15:45:09 INFO - Usage: mozinstall [options] installer 15:45:09 INFO - Options: 15:45:09 INFO - -h, --help show this help message and exit 15:45:09 INFO - -d DEST, --destination=DEST 15:45:09 INFO - Directory to install application into. [default: 15:45:09 INFO - "/builds/slave/test-pgo"] 15:45:09 INFO - --app=APP Application being installed. [default: firefox] 15:45:09 INFO - mkdir: /builds/slave/test-pgo/build/application 15:45:09 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'] 15:45:09 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 15:45:25 INFO - Reading from file tmpfile_stdout 15:45:25 INFO - Output received: 15:45:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:45:25 INFO - Running post-action listener: _resource_record_post_action 15:45:25 INFO - ##### 15:45:25 INFO - ##### Running run-tests step. 15:45:25 INFO - ##### 15:45:25 INFO - Running pre-action listener: _resource_record_pre_action 15:45:25 INFO - Running main action method: run_tests 15:45:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:45:25 INFO - Python 2.7.3 15:45:25 INFO - Return code: 0 15:45:25 INFO - grabbing minidump binary from tooltool 15:45:25 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')]} 15:45:25 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 0x11fb540>, '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 0x11fc440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11fc8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:45:25 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 15:45:25 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 15:45:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:25 INFO - Return code: 0 15:45:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:45:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:45:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:45:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:45:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:45:26 INFO - Return code: 0 15:45:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:45:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/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-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:45:26 INFO - Using env: {'DISPLAY': ':0', 15:45:26 INFO - 'HOME': '/home/cltbld', 15:45:26 INFO - 'LANG': 'en_US.UTF-8', 15:45:26 INFO - 'LANGUAGE': 'en_US:en', 15:45:26 INFO - 'LOGNAME': 'cltbld', 15:45:26 INFO - 'MAIL': '/var/mail/cltbld', 15:45:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:26 INFO - 'MOZ_NO_REMOTE': '1', 15:45:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:26 INFO - 'NO_EM_RESTART': '1', 15:45:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:26 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:45:26 INFO - 'SHELL': '/bin/bash', 15:45:26 INFO - 'SHLVL': '1', 15:45:26 INFO - 'TERM': 'linux', 15:45:26 INFO - 'TMOUT': '86400', 15:45:26 INFO - 'USER': 'cltbld', 15:45:26 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450999900.95860-285059883', 15:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:26 INFO - '_': '/tools/buildbot/bin/python'} 15:45:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:45:26 INFO - mozversion application_buildid: 20151224133004 15:45:26 INFO - mozversion application_changeset: fedf404c32d9759b27e8493dc03413ed37bd1224 15:45:26 INFO - mozversion application_display_name: Nightly 15:45:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:26 INFO - mozversion application_name: Firefox 15:45:26 INFO - mozversion application_remotingname: firefox 15:45:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:26 INFO - mozversion application_vendor: Mozilla 15:45:26 INFO - mozversion application_version: 46.0a1 15:45:26 INFO - mozversion platform_buildid: 20151224133004 15:45:26 INFO - mozversion platform_changeset: fedf404c32d9759b27e8493dc03413ed37bd1224 15:45:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:26 INFO - mozversion platform_version: 46.0a1 15:45:26 INFO - using testdate: 1451000726 15:45:26 INFO - actual date: 1451000726 15:45:26 INFO - starting webserver on 'localhost:58349' 15:45:26 INFO - SUITE-START | Running 3 tests 15:45:26 INFO - TEST-START | dromaeo_css 15:45:26 INFO - operating with platform_type : linux_ 15:45:26 INFO - Initialising browser for dromaeo_css test... 15:45:26 INFO - TEST-INFO | started process 14960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDIofyu/profile http://localhost:58349/getInfo.html) 15:45:31 INFO - PROCESS | 14960 | __metrics Screen width/height:1600/1200 15:45:31 INFO - PROCESS | 14960 | colorDepth:24 15:45:31 INFO - PROCESS | 14960 | Browser inner width/height: 1024/697 15:45:31 INFO - PROCESS | 14960 | __metrics 15:45:31 INFO - PROCESS | 14960 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:45:32 INFO - TEST-INFO | 14960: exit 0 15:45:32 INFO - Browser initialized. 15:45:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:32 INFO - TEST-INFO | started process 15092 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDIofyu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:44 INFO - PROCESS | 15092 | RSS: Main: 151388160 15:45:44 INFO - PROCESS | 15092 | 15:46:33 INFO - PROCESS | 15092 | 1451000793633 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] 15:48:41 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58349/tests/dromaeo/cssquery-ext.html) 15:48:43 INFO - PROCESS | 15092 | RSS: Main: 158339072 15:48:43 INFO - PROCESS | 15092 | 15:51:45 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-ext.html (next: http://localhost:58349/tests/dromaeo/cssquery-jquery.html) 15:51:46 INFO - PROCESS | 15092 | RSS: Main: 154058752 15:51:46 INFO - PROCESS | 15092 | 15:54:47 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58349/tests/dromaeo/cssquery-mootools.html) 15:54:48 INFO - PROCESS | 15092 | RSS: Main: 155045888 15:54:48 INFO - PROCESS | 15092 | 15:57:50 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58349/tests/dromaeo/cssquery-prototype.html) 15:57:50 INFO - PROCESS | 15092 | RSS: Main: 152166400 15:57:50 INFO - PROCESS | 15092 | 16:00:53 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58349/tests/dromaeo/cssquery-yui.html) 16:00:53 INFO - PROCESS | 15092 | RSS: Main: 152449024 16:00:53 INFO - PROCESS | 15092 | 16:03:55 INFO - PROCESS | 15092 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-yui.html (next: http://localhost:58349/tests/dromaeo/cssquery-dojo.html) 16:03:56 INFO - PROCESS | 15092 | RSS: Main: 155414528 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | __start_tp_report 16:03:56 INFO - PROCESS | 15092 | _x_x_mozilla_page_load 16:03:56 INFO - PROCESS | 15092 | _x_x_mozilla_page_load_details 16:03:56 INFO - PROCESS | 15092 | |i|pagename|runs| 16:03:56 INFO - PROCESS | 15092 | |0;dojo.html;3091.8608662610186;3148.5277208418734;3179.793313434628;3202.0553936588717;3207.791493552919;5074.517920797518;5175.560077393421;5179.4561571035065;5189.870253243666;5226.398964119127;5092.541671249587;5101.107306221405;5111.2333150027425;5200.765965531551;5204.713740744258;4752.287156926463;4808.326834243208;4811.30236115763;4860.222364421693;4880.585150262232;4549.636029117679;4831.975840120795;4842.152623290927;4858.271259311096;4929.975350123263;4604.654650901179;4678.6491013174145;4695.812167513295;4726.700157456709;4770.403699537558;4719.126961512131;4728.929066064012;4739.73931433771;4758.00081982784;4778.139934811733;4698.412698412699;4701.576858082789;4711.646626502992;4718.292256161569;4743.691660042086;4864.854054378375;4897.559219670246;4898.853034408973;4916.729579873106;4963.478834722375;5476.67139971603;5487.176923461513;5490.862728431821;5509.944900550983;5617.38208797032;5529.170624406372;5571.8607034824045;5587.357453892813;5607.551395888319;5634.9857025735355;5171.146760784466;5183.196604526304;5191.5846732261325;5195.922061169085;5236.423993360727;5472.835814925558;5570.248016517799;5638.520725738358;5687.886242275132;5760.942390576124;5473.8357849264585;5483.835484935458;5485.17722341644;5487.945120548823;5495.477929596682;5480.095784195642;5522.30971128609;5522.779088836482;5549.112142057252;5579.163125531203;5452.318460192476;5455.672659640434;5547.41752116022;5547.472990065938;5550.389457159709;5476.397596264408;5508;5551.805686800943;5574.58190635704;5617.8033768817895;4271.594198551133;4277.337012763027;4277.850275240352;4296.377025331372;4312.353147027971;3796.734228603971;3846.807659617008;3854.479645247912;3888.4556162137324;3892.5328960524917;5206.062908676475;5240.842774716764;5257.474252574789;5262.894742105136;5313.203019547099;5471.452854714496;5501.312335958005;5502.0921547944945;5507.697076660742;5562.415946325658;5127.615428842777;5156.278121063054;5191.948080519146;5192.143296356059;5228.55557277628;4826.276058591239;4826.8793280168275;4829.420469543677;4846.39420072491;4854.320395144682;5584.748686309126;5589.55283577321;5598.524125449301;5619.662820230799;5634.464725850956;5422.6475279106735;5462.617616766788;5564.777408903598;5576.525995290446;5669.574781891457;5597.944020559742;5612.579056570855;5629.043062679436;5632.042552766122;5632.5775566831835;5478.233047373451;5490.121580547253;5504.944950550604;5507.173923911285;5552.000639884859;5409.918851217313;5502.752376143003;5522.6134170609275;5528.917066243929;5532.944670553404;5363.570914326767;5367.758450869642;5397.055515284731;5478.91781623268;5519.061759500814;5382.085045542189;5382.542483888913;5384.084705599979;5392.325959255093;5410.621256512007;5184.222366644883;5311.389190243017;5315.3090098286975;5320.840374788762;5324.520793128637;5362.1420572708175;5408.621396502207;5424.511793938565;5425.891482170414;5433.755481003285;5303.124984377689;5327.3074500314715;5336.146216605324;5423.023855706011;5459.617826752089 16:03:56 INFO - PROCESS | 15092 | |1;ext.html;558.8686658635222;560.5655616896904;561.0938334589638;561.7219476359201;564.3904583050305;35512.467312990295;35946.820265898634;36007.819960900226;36072.63927360729;36156.27687446253;37846.43230351547;38098.42852357217;38328.80835595825;38447.23105537888;38507.61492385082;8399.790005249857;8639.568021598927;8643.394962352639;8644.697435589756;8685.174908383726;8344.457610255315;8479.152084791502;8492.53291068991;8673.04596494385;8758.824823503526;8672;8749.16882896124;8759.912400875974;8768.561571921411;8778;8572.399932004762;8626.094260102662;8627.137286271385;8699.869501957475;8715.346349023785;8551.444156129894;8571.485710857369;8707.956460217722;8708.695195668184;8710.259627931633;35860.28279434397;36696.26607467836;36704.632953670385;36716.63283367159;36800.44799328012;3065.509518477033;3078.4458797416455;3111.20664230622;3295.423300922329;3352.8155951422664;28767.280817979718;28844.42311153786;29451.11646650604;29685.406291874042;30109.247268818235;3777.1501412182315;3857.9807100964595;3865.7873816940055;3870.845166193349;3940.251352243093;264688.6765566179;264979;266253;267633;269259;51985.7400712994;52499.21251181235;58743.4125658738;59120;59222;58949.705251474326;59959.40040599625;59980.100298495556;60034.0977836448;60456;14757.77863332051;14779.33492992818;14795;14875.404983800743;14884.553463396116;11212.27120237182;11231.382273974847;11260.774784504429;11264.155188360906;11278.041366483776;19441.61116777685;19847.60304793896;19887.60224795496;19888.801111988985;19922.800771992384;7923.524588524707;8010.239027292398;8054.436189466798;8098.919010809816;8099.109097999215;922.5202894494826;999.3254553176722;1005.5726316315537;1063.1919740996743;1066.8773091094467;27540.173794786187;27651.58522622162;27744.583831242144;28024.71975280221;28093;999.3354419311077;1009.5154325923597;1031.0874875735028;1039.6828967165088;1094.2176343914139;14400.135991840523;14483.710325793425;14664.926675366554;14842.332095055748;14845.703085938438;312198;314299;315607;315952;316583;49088;49554.75222623936;49733.25400119001;50008.74995624999;50200;1310.33173081729;1318.7032917593465;1327.422571181539;1328.6479083043002;1333.4732780551822;26507.33731656724;27354;27408.725912741415;27605.86197069082;27655.861720691268;43879.122417552106;44374.3343849849;44375.556244438434;44387.778061109486;44603.77698111489;238250;240974;242880;243377;245116;31944.201394965312;41280.38079428871;41496.79251603843;41815.1636967265;41883.1623367537;38673.22653546857;38683.41974870436;39565;39871.60128398679;40044.399334010595;32190;32758.181045474055;32958.835205823816;37297.6270237305;38458.80770596129;35292.64707352893;35610;35901.28197436089;36022;36624.08439789026;34813.82593087018;34872.65127348694;34928.126796830285;35404.64595354014;35428.29143417169;30959.226019348796;32153.356932860745;32393;32589;32819.34361312808;24771.62842557327;24796.628050579617;24810.751892480843;24866.378340541632;25299.367515812253 16:03:56 INFO - PROCESS | 15092 | |2;jquery.html;358.85107680312655;364.1715098151706;365.38979903561057;367.37546171508444;368.60927416938046;11237.83143252852;11667.12496562759;16189.83810161898;17016.829831701696;17789.822101778962;17699.1150442478;17702.734458983126;17806;17967.460976170736;17986.28054877803;5787.739551720172;5902.527797776168;5928.525717942576;5953.613015154023;5954.255718035246;5318.228856815759;5940.138679891413;5988.520918326523;6021.337652858182;6021.698915054251;5937.37657545958;5979.1629171915965;5985.191999080133;5992.131140984577;6000.639961602296;5818.156367326714;5945.672987985659;5973.104034394853;6068.362821903725;6071.392860713893;5837.9124313135335;5839.357670656224;5839.970800145972;5848.4151584841175;5856.736446859902;22260.226301032122;22298.554028919494;22593.2092376766;23263.18578849749;23594.410139746473;2175.140819376353;2227.1982086448866;2245.1019592163266;2365.8225633077586;2625.5930330798756;14321.140731556035;14565.198914059829;14722.779158312635;14872.776908346275;14902.70194596113;1930.5945751392223;2011.8189362957405;2027.9695804562944;2048.774634790172;2049.11887888208;62258;67311.66344168296;68103;68454.31545684529;68605.65697171532;15178.241087945558;15547;15594.454194103151;15616.219189040503;15642.921785391;13003.934980325037;13131.277779722015;13341.733165336638;23922;23941.401464963514;7110.537815042006;7189.352958233784;7251.311125443074;7271.309225623558;7294.9270507295305;7005.824854378681;7160.856782864314;7194.748183813542;7228.421726261887;7378.96310518444;4527.411436513298;4545.568171023748;4601.792919318638;4604.769761511911;4625.791839367236;1832.3128826689992;1908.6469003234447;1911.1972971352066;1932.1981377728086;1955;941.5668792355593;948.6489998700525;965.0976337124811;965.2471072563412;1001.3791449301334;15040.097594144387;16450.259738311805;16742.497725068268;16879.493615191564;17931.73102403465;908.8046070094962;909.554318383987;942.1661829281136;952.228694757235;958.4297343080996;9533.618655253713;9950;9972.351797133164;10022.372702313489;10030.548625311878;533375;533773.6556586117;540150;555331;559619;40582.59417405788;40798.38802417966;71223.93164102543;78524;81288.18711812925;1134.211722852626;1137.954481820718;1147.4492243722893;1148.0700632487878;1148.2478976270556;15261;15477.452254774882;15505.534833955;15633.530994070195;15639.452619158275;31192.688073118978;35013.824930875184;35185.824070879484;35549.111272217364;36482.452763209105;41998.37002444905;42459.36310955277;42805.78597107119;46651.76674116608;47643.76178119087;9033.90966090357;9341.813163736551;9395.530223488935;9440.197583205505;9682.75793105178;10743.570257189625;10931.945340273247;10963;15778.605534861721;17016.23426945766;14105.435782568582;14337.139771613736;14407.351669175121;14482.493112741004;14872.62818429548;14330.283485825876;14688.192149431883;14730.631734206301;14862.702745945237;15105.244737762849;14373.425062997363;14449;15037.774433383289;15155.772663410278;15651.139187344805;9439.386439881386;9648.75878103053;9717;9725.41647501124;9754.12212900814;10450.68647940563;13102.541411050568;14341.498047568284;14602.342894569558;15101.848981510044 16:03:56 INFO - PROCESS | 15092 | |3;mootools.html;1378.1799829101685;1415.3984556563457;1551.177875725865;1751.0806826416122;1780.6883795335814;7186.281371862811;7287.927120728805;7422.3690986266165;7534.284242996913;7565.3947684185205;7459.142198647157;7460.440466964972;7543.585102819343;7551.28262815033;7551.962240188791;2198.7251593550845;2231.966520502194;2236.9217077402295;2239.988800055997;2251.986606027286;2220.467087898901;2244.7306323241232;2288.1762565476415;2288.6567014947723;2288.771122887706;2152.397328747953;2193.5283913958574;2198.6372248578964;2212.723409573803;2215.7341119065654;2201.152556265833;2215.3575463115676;2244.236959433792;2250.3586477853733;2259.627161518356;2226.343228747507;2250.774922507736;2251.2008237075765;2251.6960210371553;2261.6155253606926;7322.853542929165;7443.516171448892;7490.250974902466;7492.812679682997;7499.362554182846;4467.508574056851;4553.886152846206;4586.839460618896;4612;4622.976885115587;2930.150256425634;3020.018493989462;3041.7870749047574;3043.680413556589;3058.189579761365;970.4856426094182;973.0123924216925;999.8150342186646;1005.4620777883797;1025.5743866295552;9921.156701680366;9930.553125109387;9965.053319934595;9978.451185184811;10106.797864042677;3974.1455587048345;3983.143624120828;4009.0979529605606;4035.6973227008093;4128.896777580585;8212.425130240945;8227.917720822836;8278.917210827934;8280.04779450359;8310.750677479686;4485.865424037284;4529.071540334224;4534.0478499515475;4541.182587134347;4544.454665440168;4192.874213773592;4199.517055538591;4209.6000879916355;4221.957780422156;4236.046889449911;3347.4811404232382;3367.2087059540986;3371.2077661749468;3380.4253276942977;3410.2838403935452;1067.9145668346514;1072.1797824664138;1076.2520048566328;1077.590515604081;1082.9133669306436;931.3852857114407;951.9333646644668;1100.9815920273716;1150.4017910686396;1347;6719.832004199934;6742.190937087581;6779.593224406552;6817.250102488722;6819.454443644497;1171.800793865045;1198.2870192235605;1218.2020776391478;1219.7682440336307;1222.7684475831643;5485.369182543979;5542.3626282977975;5548.833534993957;5549.250851135045;5555.611107222537;8287.62705678246;8339.166083391612;8579.399442038997;8633;8662.393632445668;8474.237318641228;8474.237318641228;8544.060153383123;8594.312455003585;8687.478751274944;7101.502894797418;7110.57336559808;7146.571205727673;7190.712371505186;7274.018007569016;6909.239983601699;6911.205211400753;6914.585124892523;6915.550489218184;6952;7937.563434010954;7987.400944929037;8106.83786324282;8189.79525511867;8200;8141.633626486704;8284.420090593601;8285.378596605158;8296.70961516344;8300.252977232078;6370.203724534434;6379.234491861006;6415.230172379344;6444.9355506444335;6502.934970650233;7263.782086537412;7313.414926805736;7324.340809327186;7339.486235963432;7372.336489715737;6747.325267473213;6851.48613853953;7056.858862822817;7067.82330441743;7171.713131474683;6533.934660653333;6551.967240163769;6555.672216389257;6645.136132302963;6753.797386078426;6334.303226645157;6437.613743175424;6476.0933469313395;6504.804855854332;6518.511111666549;6079.300880398634;6092.055731361646;6093.055576385667;6135.325114237341;6141.293751218488;6112.083187521907;6180.969095154495;6203.379662033941;6218.036204388327;6236.18929539157 16:03:56 INFO - PROCESS | 15092 | |4;prototype.html;341.9179396944733;346.31084142556307;349.94400895856666;355.60527814126317;356.41192033145325;6167.753289868406;6213.440790328869;6231.719572619231;6237.750489980401;6322.9051564226575;6220.906686399708;6276.748930042804;6291.1821463209835;6293.811185664426;6301.527385446087;4763.380760501139;4764.547368000034;4768.356271903301;4776.47458779534;4780.832670856521;4774.546418090275;4776.235802271637;4779.402574678165;4790.688605240648;4791.904161916759;4607.58531732144;4700.929486057712;4705.3647757552635;4718.787654555536;4742.928856067162;4698.835540756091;4711;4713.316569097462;4739.881502962419;4743.501932297094;4152.750834949913;4154.979225103885;4155.293600087993;4162.5629308922735;4165.66674666026;5929.436703513159;5969.761209551612;5973.342932277446;5978.282606087254;5978.521718262528;5369.7583608737705;5519.282493275889;5528.9723551381985;5529.225908372831;5540.695261760601;6597.241317248529;6604.787396222271;6609.801705948781;6613.371729685672;6616.900746488806;4552.408186935677;4552.908941821145;4565.931511027337;4568.200564901129;4587.931181032287;6811.318868113149;6858.931410685879;6914.101166848328;6938.514303998722;6959.965200173967;4676.134915040729;4683.227267500893;4683.625309975194;4692.554207350297;4693.601043911238;4745.738984355894;4758.738269395217;4759.976200118977;4762.8333008345235;4766.451858036301;5444.40111587725;5475.0418676731415;5503.422140675251;5512;5519;6422.903656445157;6604.372584604551;6605.636689982097;6626.602403855784;6640.83397915056;1632.3062698353153;1659.9170041497878;1688.1643586424798;1689.1047744695331;1689.932402703878;1119.0991252042184;1119.138263537072;1134.4554613785429;1135.1883403366633;1136.1933027550367;6199.845003874939;6242.781502647385;6244.500439964882;6252.406021427957;6265;6731.932680673229;6782.626955517395;6809.795706128824;6821.420179284717;6826.590404575642;6069.302030266487;6190.195274614362;6224.502039836802;6228.626282423069;6237.282712488031;3647.1429214134655;3649.5255616770182;3664.212194378168;3670.3026424979703;3671.5227020487164;6788.558743681645;6842.04211410403;6859.2454829968665;6867;6878.415334696607;6795.1845778506895;6892.138482689664;6973.05863708403;6995.685194166274;7034.015237866703;6811.182658081062;6870.31296870319;6874.553154044971;6876.621785801729;6892.724291028403;6740.955151951455;6747.055412242388;6804.55770374924;6814.4548436124;6815.727370905108;6636.402723754885;6709.597424154566;6721.260661327348;6725.226598941184;6726.697298621476;7005.789826305219;7039.296070392919;7045.11936007999;7054.964725176341;7065.1521817382245;4684.063187362473;4694.413198350207;4704.50602686713;4712;4716.339712440193;6757.3242675732035;6934.375906168469;6941.548799328028;6971.965140174267;6975.476839236976;6688.197416310074;6723.5293529452465;6748.257691654012;6758.695858686273;6775.762848300285;6726.697298621476;6742.595444273359;6744.69648865812;6745.898811517929;6758.628275444898;6470.676466176767;6611.735530578915;6622.569532980341;6625.105610742488;6625.966870165811;6774.762883299061;6781.89827152603;6786.423154031765;6791.898121528082;6796.252412234551;6579.605223686594;6587.868242635216;6591.307912669293;6616.470682345497;6633.900491492535 16:03:56 INFO - PROCESS | 15092 | |5;yui.html;846.4208631304639;849.6049337058269;850.6724910909298;866.7443104284232;882.5013867165047;12567;12808.48766049358;13843.861561384396;13972.37124329405;13982.510612128577;12819.423125959354;12842.52310984237;12855.550055748028;12872.806907896389;12899.38757655293;794.3843521271018;822.1408627983772;824.6536454689045;824.9628766705482;826.8511667899776;809.7611204694629;832.3133414932674;832.7918020494876;833.1168960901433;834.64110432514;860.5095095795399;868.8653258744905;869.7738587967142;870.7648934787603;872.4067634008871;856.5845564901018;859.7721603775004;861.0958493581745;862.5169904853271;863.6804382378498;636.4685487617845;638.8339031851706;639.3063526074216;640.5132099604288;642.881067002606;12778.361081945866;12797.360131993457;12869.485220591165;13011;13045.282509461977;11279.830802537968;11513.366764827932;11612.18714689972;12168.695782605417;12297;10143.644972426004;10259.897401025968;10299.17606591471;10310.278280520291;10624.575016999312;3583.4445660922597;3607.4769158472136;3622.3479773640734;3626.4016437287814;3727.5340582427198;46963.29555056677;47458.05083898337;47596.52403475955;47776;48155.75922120402;9435.339526233234;9653.517324133905;9653.951730241304;9726.262696466354;9870.25973052024;17637.382691605733;17692.734608980874;17719.114044297734;17748.467545973643;17752.20115094824;7264.309890560388;7381;7439.739609113655;7545.7358992435;7618.885716714254;4143.3370660694145;4238.470191226097;4240.6395456385935;4278.144371125787;4283.2932566126865;2864.7135286471184;2867.5842002909462;2896.739293463598;2897.5943367928508;2898.7970842040854;532.5393534592549;539.029746456377;544.9373322067934;544.9673019618835;546.66926509462;563.4337490821698;649.9415052645285;663.1644128398157;665.069439611901;703.5356664601338;7989.840203195903;8644.481331120152;8864.185693453976;8885;9034.412763170372;659.9505037122235;663.2505269045947;698.4691634357823;701.3547536266647;704.0405590735514;3955.4264631628253;3993.92012159761;4009.8195581198916;4103.466549348565;4153.439285696452;54099;54238.457615423344;54503.45496544984;54513;56404.435955640736;47889;49148.75425622921;49928.75035624798;50907.181961353046;51004.74497627488;44336.669899903696;44788.55211447909;45290.54709452929;45806;46315.536844631126;8038.115807261313;8107.83784324322;8303.626336814737;8379.832403351777;8402.41183117176;33078.834605826814;33227.16932076718;34222.31555368829;34468;36592.81703591465;42728.78635606802;42897.785511072245;43146.784266078466;43925;44415.77792111148;10775.92240775916;11080.5567777288;11169.944150279196;11315;11449.6149983262;12164.5438795329;12192.329421881881;12297.200681955645;12395.566155184526;12592.307423091817;11091.833622495831;11370.20408571392;11381.487833047368;11434.71413214643;11746.353950532803;11317.490712917774;11441.084713223088;11764.88235117672;11828.46771895284;12201.51193952232;11196.272242304223;11350;11351;11644.301341919512;12182.39088045612;9561.808763824823;9580.856287155559;9713.36863103896;9734.172595329477;10193.23550733683;8899.955500222457;9085.409448385833;9658.275629327689;9728.708138755848;10334.173266138541 16:03:56 INFO - PROCESS | 15092 | __end_tp_report 16:03:56 INFO - PROCESS | 15092 | __start_cc_report 16:03:56 INFO - PROCESS | 15092 | _x_x_mozilla_cycle_collect,307 16:03:56 INFO - PROCESS | 15092 | __end_cc_report 16:03:56 INFO - PROCESS | 15092 | __startTimestamp1451001836172__endTimestamp 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | ------- Summary: start ------- 16:03:56 INFO - PROCESS | 15092 | Number of tests: 6 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#0] dojo.html Cycles:165 Average:5143.79 Median:5336.15 stddev:544.25 (10.2%) stddev-sans-first:521.57 16:03:56 INFO - PROCESS | 15092 | Values: 3091.9 3148.5 3179.8 3202.1 3207.8 5074.5 5175.6 5179.5 5189.9 5226.4 5092.5 5101.1 5111.2 5200.8 5204.7 4752.3 4808.3 4811.3 4860.2 4880.6 4549.6 4832.0 4842.2 4858.3 4930.0 4604.7 4678.6 4695.8 4726.7 4770.4 4719.1 4728.9 4739.7 4758.0 4778.1 4698.4 4701.6 4711.6 4718.3 4743.7 4864.9 4897.6 4898.9 4916.7 4963.5 5476.7 5487.2 5490.9 5509.9 5617.4 5529.2 5571.9 5587.4 5607.6 5635.0 5171.1 5183.2 5191.6 5195.9 5236.4 5472.8 5570.2 5638.5 5687.9 5760.9 5473.8 5483.8 5485.2 5487.9 5495.5 5480.1 5522.3 5522.8 5549.1 5579.2 5452.3 5455.7 5547.4 5547.5 5550.4 5476.4 5508.0 5551.8 5574.6 5617.8 4271.6 4277.3 4277.9 4296.4 4312.4 3796.7 3846.8 3854.5 3888.5 3892.5 5206.1 5240.8 5257.5 5262.9 5313.2 5471.5 5501.3 5502.1 5507.7 5562.4 5127.6 5156.3 5191.9 5192.1 5228.6 4826.3 4826.9 4829.4 4846.4 4854.3 5584.7 5589.6 5598.5 5619.7 5634.5 5422.6 5462.6 5564.8 5576.5 5669.6 5597.9 5612.6 5629.0 5632.0 5632.6 5478.2 5490.1 5504.9 5507.2 5552.0 5409.9 5502.8 5522.6 5528.9 5532.9 5363.6 5367.8 5397.1 5478.9 5519.1 5382.1 5382.5 5384.1 5392.3 5410.6 5184.2 5311.4 5315.3 5320.8 5324.5 5362.1 5408.6 5424.5 5425.9 5433.8 5303.1 5327.3 5336.1 5423.0 5459.6 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#1] ext.html Cycles:180 Average:44267.93 Median:35924.05 stddev:72069.76 (200.6%) stddev-sans-first:72197.21 16:03:56 INFO - PROCESS | 15092 | Values: 558.9 560.6 561.1 561.7 564.4 35512.5 35946.8 36007.8 36072.6 36156.3 37846.4 38098.4 38328.8 38447.2 38507.6 8399.8 8639.6 8643.4 8644.7 8685.2 8344.5 8479.2 8492.5 8673.0 8758.8 8672.0 8749.2 8759.9 8768.6 8778.0 8572.4 8626.1 8627.1 8699.9 8715.3 8551.4 8571.5 8708.0 8708.7 8710.3 35860.3 36696.3 36704.6 36716.6 36800.4 3065.5 3078.4 3111.2 3295.4 3352.8 28767.3 28844.4 29451.1 29685.4 30109.2 3777.2 3858.0 3865.8 3870.8 3940.3 264688.7 264979.0 266253.0 267633.0 269259.0 51985.7 52499.2 58743.4 59120.0 59222.0 58949.7 59959.4 59980.1 60034.1 60456.0 14757.8 14779.3 14795.0 14875.4 14884.6 11212.3 11231.4 11260.8 11264.2 11278.0 19441.6 19847.6 19887.6 19888.8 19922.8 7923.5 8010.2 8054.4 8098.9 8099.1 922.5 999.3 1005.6 1063.2 1066.9 27540.2 27651.6 27744.6 28024.7 28093.0 999.3 1009.5 1031.1 1039.7 1094.2 14400.1 14483.7 14664.9 14842.3 14845.7 312198.0 314299.0 315607.0 315952.0 316583.0 49088.0 49554.8 49733.3 50008.7 50200.0 1310.3 1318.7 1327.4 1328.6 1333.5 26507.3 27354.0 27408.7 27605.9 27655.9 43879.1 44374.3 44375.6 44387.8 44603.8 238250.0 240974.0 242880.0 243377.0 245116.0 31944.2 41280.4 41496.8 41815.2 41883.2 38673.2 38683.4 39565.0 39871.6 40044.4 32190.0 32758.2 32958.8 37297.6 38458.8 35292.6 35610.0 35901.3 36022.0 36624.1 34813.8 34872.7 34928.1 35404.6 35428.3 30959.2 32153.4 32393.0 32589.0 32819.3 24771.6 24796.6 24810.8 24866.4 25299.4 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#2] jquery.html Cycles:180 Average:29053.94 Median:35367.47 stddev:88758.01 (251.0%) stddev-sans-first:88980.85 16:03:56 INFO - PROCESS | 15092 | Values: 358.9 364.2 365.4 367.4 368.6 11237.8 11667.1 16189.8 17016.8 17789.8 17699.1 17702.7 17806.0 17967.5 17986.3 5787.7 5902.5 5928.5 5953.6 5954.3 5318.2 5940.1 5988.5 6021.3 6021.7 5937.4 5979.2 5985.2 5992.1 6000.6 5818.2 5945.7 5973.1 6068.4 6071.4 5837.9 5839.4 5840.0 5848.4 5856.7 22260.2 22298.6 22593.2 23263.2 23594.4 2175.1 2227.2 2245.1 2365.8 2625.6 14321.1 14565.2 14722.8 14872.8 14902.7 1930.6 2011.8 2028.0 2048.8 2049.1 62258.0 67311.7 68103.0 68454.3 68605.7 15178.2 15547.0 15594.5 15616.2 15642.9 13003.9 13131.3 13341.7 23922.0 23941.4 7110.5 7189.4 7251.3 7271.3 7294.9 7005.8 7160.9 7194.7 7228.4 7379.0 4527.4 4545.6 4601.8 4604.8 4625.8 1832.3 1908.6 1911.2 1932.2 1955.0 941.6 948.6 965.1 965.2 1001.4 15040.1 16450.3 16742.5 16879.5 17931.7 908.8 909.6 942.2 952.2 958.4 9533.6 9950.0 9972.4 10022.4 10030.5 533375.0 533773.7 540150.0 555331.0 559619.0 40582.6 40798.4 71223.9 78524.0 81288.2 1134.2 1138.0 1147.4 1148.1 1148.2 15261.0 15477.5 15505.5 15633.5 15639.5 31192.7 35013.8 35185.8 35549.1 36482.5 41998.4 42459.4 42805.8 46651.8 47643.8 9033.9 9341.8 9395.5 9440.2 9682.8 10743.6 10931.9 10963.0 15778.6 17016.2 14105.4 14337.1 14407.4 14482.5 14872.6 14330.3 14688.2 14730.6 14862.7 15105.2 14373.4 14449.0 15037.8 15155.8 15651.1 9439.4 9648.8 9717.0 9725.4 9754.1 10450.7 13102.5 14341.5 14602.3 15101.8 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#3] mootools.html Cycles:180 Average:5203.86 Median:6285.25 stddev:2628.40 (41.8%) stddev-sans-first:2620.05 16:03:56 INFO - PROCESS | 15092 | Values: 1378.2 1415.4 1551.2 1751.1 1780.7 7186.3 7287.9 7422.4 7534.3 7565.4 7459.1 7460.4 7543.6 7551.3 7552.0 2198.7 2232.0 2236.9 2240.0 2252.0 2220.5 2244.7 2288.2 2288.7 2288.8 2152.4 2193.5 2198.6 2212.7 2215.7 2201.2 2215.4 2244.2 2250.4 2259.6 2226.3 2250.8 2251.2 2251.7 2261.6 7322.9 7443.5 7490.3 7492.8 7499.4 4467.5 4553.9 4586.8 4612.0 4623.0 2930.2 3020.0 3041.8 3043.7 3058.2 970.5 973.0 999.8 1005.5 1025.6 9921.2 9930.6 9965.1 9978.5 10106.8 3974.1 3983.1 4009.1 4035.7 4128.9 8212.4 8227.9 8278.9 8280.0 8310.8 4485.9 4529.1 4534.0 4541.2 4544.5 4192.9 4199.5 4209.6 4222.0 4236.0 3347.5 3367.2 3371.2 3380.4 3410.3 1067.9 1072.2 1076.3 1077.6 1082.9 931.4 951.9 1101.0 1150.4 1347.0 6719.8 6742.2 6779.6 6817.3 6819.5 1171.8 1198.3 1218.2 1219.8 1222.8 5485.4 5542.4 5548.8 5549.3 5555.6 8287.6 8339.2 8579.4 8633.0 8662.4 8474.2 8474.2 8544.1 8594.3 8687.5 7101.5 7110.6 7146.6 7190.7 7274.0 6909.2 6911.2 6914.6 6915.6 6952.0 7937.6 7987.4 8106.8 8189.8 8200.0 8141.6 8284.4 8285.4 8296.7 8300.3 6370.2 6379.2 6415.2 6444.9 6502.9 7263.8 7313.4 7324.3 7339.5 7372.3 6747.3 6851.5 7056.9 7067.8 7171.7 6533.9 6552.0 6555.7 6645.1 6753.8 6334.3 6437.6 6476.1 6504.8 6518.5 6079.3 6092.1 6093.1 6135.3 6141.3 6112.1 6181.0 6203.4 6218.0 6236.2 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#4] prototype.html Cycles:180 Average:5527.40 Median:6240.27 stddev:1665.37 (26.7%) stddev-sans-first:1623.93 16:03:56 INFO - PROCESS | 15092 | Values: 341.9 346.3 349.9 355.6 356.4 6167.8 6213.4 6231.7 6237.8 6322.9 6220.9 6276.7 6291.2 6293.8 6301.5 4763.4 4764.5 4768.4 4776.5 4780.8 4774.5 4776.2 4779.4 4790.7 4791.9 4607.6 4700.9 4705.4 4718.8 4742.9 4698.8 4711.0 4713.3 4739.9 4743.5 4152.8 4155.0 4155.3 4162.6 4165.7 5929.4 5969.8 5973.3 5978.3 5978.5 5369.8 5519.3 5529.0 5529.2 5540.7 6597.2 6604.8 6609.8 6613.4 6616.9 4552.4 4552.9 4565.9 4568.2 4587.9 6811.3 6858.9 6914.1 6938.5 6960.0 4676.1 4683.2 4683.6 4692.6 4693.6 4745.7 4758.7 4760.0 4762.8 4766.5 5444.4 5475.0 5503.4 5512.0 5519.0 6422.9 6604.4 6605.6 6626.6 6640.8 1632.3 1659.9 1688.2 1689.1 1689.9 1119.1 1119.1 1134.5 1135.2 1136.2 6199.8 6242.8 6244.5 6252.4 6265.0 6731.9 6782.6 6809.8 6821.4 6826.6 6069.3 6190.2 6224.5 6228.6 6237.3 3647.1 3649.5 3664.2 3670.3 3671.5 6788.6 6842.0 6859.2 6867.0 6878.4 6795.2 6892.1 6973.1 6995.7 7034.0 6811.2 6870.3 6874.6 6876.6 6892.7 6741.0 6747.1 6804.6 6814.5 6815.7 6636.4 6709.6 6721.3 6725.2 6726.7 7005.8 7039.3 7045.1 7055.0 7065.2 4684.1 4694.4 4704.5 4712.0 4716.3 6757.3 6934.4 6941.5 6972.0 6975.5 6688.2 6723.5 6748.3 6758.7 6775.8 6726.7 6742.6 6744.7 6745.9 6758.6 6470.7 6611.7 6622.6 6625.1 6626.0 6774.8 6781.9 6786.4 6791.9 6796.3 6579.6 6587.9 6591.3 6616.5 6633.9 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - PROCESS | 15092 | [#5] yui.html Cycles:180 Average:13533.68 Median:46060.77 stddev:15459.73 (33.6%) stddev-sans-first:15473.74 16:03:56 INFO - PROCESS | 15092 | Values: 846.4 849.6 850.7 866.7 882.5 12567.0 12808.5 13843.9 13972.4 13982.5 12819.4 12842.5 12855.6 12872.8 12899.4 794.4 822.1 824.7 825.0 826.9 809.8 832.3 832.8 833.1 834.6 860.5 868.9 869.8 870.8 872.4 856.6 859.8 861.1 862.5 863.7 636.5 638.8 639.3 640.5 642.9 12778.4 12797.4 12869.5 13011.0 13045.3 11279.8 11513.4 11612.2 12168.7 12297.0 10143.6 10259.9 10299.2 10310.3 10624.6 3583.4 3607.5 3622.3 3626.4 3727.5 46963.3 47458.1 47596.5 47776.0 48155.8 9435.3 9653.5 9654.0 9726.3 9870.3 17637.4 17692.7 17719.1 17748.5 17752.2 7264.3 7381.0 7439.7 7545.7 7618.9 4143.3 4238.5 4240.6 4278.1 4283.3 2864.7 2867.6 2896.7 2897.6 2898.8 532.5 539.0 544.9 545.0 546.7 563.4 649.9 663.2 665.1 703.5 7989.8 8644.5 8864.2 8885.0 9034.4 660.0 663.3 698.5 701.4 704.0 3955.4 3993.9 4009.8 4103.5 4153.4 54099.0 54238.5 54503.5 54513.0 56404.4 47889.0 49148.8 49928.8 50907.2 51004.7 44336.7 44788.6 45290.5 45806.0 46315.5 8038.1 8107.8 8303.6 8379.8 8402.4 33078.8 33227.2 34222.3 34468.0 36592.8 42728.8 42897.8 43146.8 43925.0 44415.8 10775.9 11080.6 11169.9 11315.0 11449.6 12164.5 12192.3 12297.2 12395.6 12592.3 11091.8 11370.2 11381.5 11434.7 11746.4 11317.5 11441.1 11764.9 11828.5 12201.5 11196.3 11350.0 11351.0 11644.3 12182.4 9561.8 9580.9 9713.4 9734.2 10193.2 8900.0 9085.4 9658.3 9728.7 10334.2 16:03:56 INFO - PROCESS | 15092 | -------- Summary: end -------- 16:03:56 INFO - PROCESS | 15092 | 16:03:56 INFO - TEST-INFO | 15092: exit 0 16:03:56 INFO - TEST-OK | dromaeo_css | took 1110097ms 16:03:56 INFO - TEST-START | kraken 16:03:56 INFO - operating with platform_type : linux_ 16:03:56 INFO - Initialising browser for kraken test... 16:03:56 INFO - TEST-INFO | started process 15333 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMdl2By/profile http://localhost:58349/getInfo.html) 16:04:01 INFO - PROCESS | 15333 | __metrics Screen width/height:1600/1200 16:04:01 INFO - PROCESS | 15333 | colorDepth:24 16:04:01 INFO - PROCESS | 15333 | Browser inner width/height: 1024/697 16:04:01 INFO - PROCESS | 15333 | __metrics 16:04:01 INFO - PROCESS | 15333 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:04:02 INFO - TEST-INFO | 15333: exit 0 16:04:02 INFO - Browser initialized. 16:04:02 INFO - Running cycle 1/1 for kraken test... 16:04:02 INFO - TEST-INFO | started process 15454 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMdl2By/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:14 INFO - PROCESS | 15454 | RSS: Main: 151781376 16:04:14 INFO - PROCESS | 15454 | 16:04:16 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:17 INFO - PROCESS | 15454 | RSS: Main: 153157632 16:04:17 INFO - PROCESS | 15454 | 16:04:19 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-dft) 16:04:20 INFO - PROCESS | 15454 | RSS: Main: 152223744 16:04:20 INFO - PROCESS | 15454 | 16:04:23 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-fft) 16:04:23 INFO - PROCESS | 15454 | RSS: Main: 146509824 16:04:23 INFO - PROCESS | 15454 | 16:04:25 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-oscillator) 16:04:26 INFO - PROCESS | 15454 | RSS: Main: 146432000 16:04:26 INFO - PROCESS | 15454 | 16:04:28 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:29 INFO - PROCESS | 15454 | RSS: Main: 146911232 16:04:29 INFO - PROCESS | 15454 | 16:04:32 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:32 INFO - PROCESS | 15454 | RSS: Main: 147120128 16:04:32 INFO - PROCESS | 15454 | 16:04:36 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:36 INFO - PROCESS | 15454 | RSS: Main: 148369408 16:04:36 INFO - PROCESS | 15454 | 16:04:39 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58349/tests/kraken/driver.html?testName=json-parse-financial) 16:04:40 INFO - PROCESS | 15454 | RSS: Main: 148574208 16:04:40 INFO - PROCESS | 15454 | 16:04:41 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:42 INFO - PROCESS | 15454 | RSS: Main: 149532672 16:04:42 INFO - PROCESS | 15454 | 16:04:44 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:44 INFO - PROCESS | 15454 | RSS: Main: 150097920 16:04:44 INFO - PROCESS | 15454 | 16:04:46 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:47 INFO - PROCESS | 15454 | RSS: Main: 150159360 16:04:47 INFO - PROCESS | 15454 | 16:04:49 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:50 INFO - PROCESS | 15454 | RSS: Main: 149946368 16:04:50 INFO - PROCESS | 15454 | 16:04:53 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:53 INFO - PROCESS | 15454 | RSS: Main: 148910080 16:04:53 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58349/tests/kraken/driver.html?testName=ai-astar) 16:04:55 INFO - PROCESS | 15454 | RSS: Main: 149106688 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | __start_tp_report 16:04:55 INFO - PROCESS | 15454 | _x_x_mozilla_page_load 16:04:55 INFO - PROCESS | 15454 | _x_x_mozilla_page_load_details 16:04:55 INFO - PROCESS | 15454 | |i|pagename|runs| 16:04:55 INFO - PROCESS | 15454 | |0;ai-astar;114;110;111;111;114;123;111;114;112;112 16:04:55 INFO - PROCESS | 15454 | |1;audio-beat-detection;154;128;156;162;126;153;158;124;157;124 16:04:55 INFO - PROCESS | 15454 | |2;audio-dft;164;164;163;161;161;161;162;163;175;163 16:04:55 INFO - PROCESS | 15454 | |3;audio-fft;73;75;72;73;70;72;138;74;77;71 16:04:55 INFO - PROCESS | 15454 | |4;audio-oscillator;97;96;139;99;96;96;155;96;97;136 16:04:55 INFO - PROCESS | 15454 | |5;imaging-gaussian-blur;109;110;110;109;110;110;110;109;109;111 16:04:55 INFO - PROCESS | 15454 | |6;imaging-darkroom;146;146;148;146;147;146;146;147;146;147 16:04:55 INFO - PROCESS | 15454 | |7;imaging-desaturate;97;96;96;96;96;98;96;97;97;96 16:04:55 INFO - PROCESS | 15454 | |8;json-parse-financial;63;63;64;62;63;62;63;62;65;60 16:04:55 INFO - PROCESS | 15454 | |9;json-stringify-tinderbox;68;67;68;69;69;68;67;68;68;69 16:04:55 INFO - PROCESS | 15454 | |10;stanford-crypto-aes;84;88;88;87;94;86;87;93;86;87 16:04:55 INFO - PROCESS | 15454 | |11;stanford-crypto-ccm;116;121;121;125;126;125;127;123;122;119 16:04:55 INFO - PROCESS | 15454 | |12;stanford-crypto-pbkdf2;141;155;164;154;158;151;152;151;151;140 16:04:55 INFO - PROCESS | 15454 | |13;stanford-crypto-sha256-iterative;67;73;69;67;70;67;73;67;73;67 16:04:55 INFO - PROCESS | 15454 | __end_tp_report 16:04:55 INFO - PROCESS | 15454 | __start_cc_report 16:04:55 INFO - PROCESS | 15454 | _x_x_mozilla_cycle_collect,740 16:04:55 INFO - PROCESS | 15454 | __end_cc_report 16:04:55 INFO - PROCESS | 15454 | __startTimestamp1451001895665__endTimestamp 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | ------- Summary: start ------- 16:04:55 INFO - PROCESS | 15454 | Number of tests: 14 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:3.74 (3.3%) stddev-sans-first:3.95 16:04:55 INFO - PROCESS | 15454 | Values: 114.0 110.0 111.0 111.0 114.0 123.0 111.0 114.0 112.0 112.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:155.00 stddev:16.31 (10.5%) stddev-sans-first:16.91 16:04:55 INFO - PROCESS | 15454 | Values: 154.0 128.0 156.0 162.0 126.0 153.0 158.0 124.0 157.0 124.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:4.14 (2.5%) stddev-sans-first:4.39 16:04:55 INFO - PROCESS | 15454 | Values: 164.0 164.0 163.0 161.0 161.0 161.0 162.0 163.0 175.0 163.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:20.65 (28.3%) stddev-sans-first:21.77 16:04:55 INFO - PROCESS | 15454 | Values: 73.0 75.0 72.0 73.0 70.0 72.0 138.0 74.0 77.0 71.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:23.05 (24.0%) stddev-sans-first:23.90 16:04:55 INFO - PROCESS | 15454 | Values: 97.0 96.0 139.0 99.0 96.0 96.0 155.0 96.0 97.0 136.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 16:04:55 INFO - PROCESS | 15454 | Values: 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 111.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 16:04:55 INFO - PROCESS | 15454 | Values: 146.0 146.0 148.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:04:55 INFO - PROCESS | 15454 | Values: 97.0 96.0 96.0 96.0 96.0 98.0 96.0 97.0 97.0 96.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 16:04:55 INFO - PROCESS | 15454 | Values: 63.0 63.0 64.0 62.0 63.0 62.0 63.0 62.0 65.0 60.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 16:04:55 INFO - PROCESS | 15454 | Values: 68.0 67.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 69.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.50 stddev:3.13 (3.6%) stddev-sans-first:2.96 16:04:55 INFO - PROCESS | 15454 | Values: 84.0 88.0 88.0 87.0 94.0 86.0 87.0 93.0 86.0 87.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:124.00 stddev:3.41 (2.7%) stddev-sans-first:2.68 16:04:55 INFO - PROCESS | 15454 | Values: 116.0 121.0 121.0 125.0 126.0 125.0 127.0 123.0 122.0 119.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:153.00 stddev:7.15 (4.7%) stddev-sans-first:6.45 16:04:55 INFO - PROCESS | 15454 | Values: 141.0 155.0 164.0 154.0 158.0 151.0 152.0 151.0 151.0 140.0 16:04:55 INFO - PROCESS | 15454 | 16:04:55 INFO - PROCESS | 15454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:2.75 (4.0%) stddev-sans-first:2.79 16:04:55 INFO - PROCESS | 15454 | Values: 67.0 73.0 69.0 67.0 70.0 67.0 73.0 67.0 73.0 67.0 16:04:55 INFO - PROCESS | 15454 | -------- Summary: end -------- 16:04:55 INFO - PROCESS | 15454 | 16:04:56 INFO - TEST-INFO | 15454: exit 0 16:04:56 INFO - TEST-OK | kraken | took 59878ms 16:04:56 INFO - TEST-START | v8_7 16:04:56 INFO - operating with platform_type : linux_ 16:04:56 INFO - Initialising browser for v8_7 test... 16:04:56 INFO - TEST-INFO | started process 15741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCpH7m6/profile http://localhost:58349/getInfo.html) 16:05:01 INFO - PROCESS | 15741 | __metrics Screen width/height:1600/1200 16:05:01 INFO - PROCESS | 15741 | colorDepth:24 16:05:01 INFO - PROCESS | 15741 | Browser inner width/height: 1024/697 16:05:01 INFO - PROCESS | 15741 | __metrics 16:05:01 INFO - PROCESS | 15741 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:05:02 INFO - TEST-INFO | 15741: exit 0 16:05:02 INFO - Browser initialized. 16:05:02 INFO - Running cycle 1/1 for v8_7 test... 16:05:02 INFO - TEST-INFO | started process 15863 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCpH7m6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:14 INFO - PROCESS | 15863 | RSS: Main: 151429120 16:05:14 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | Cycle 1(1): loaded http://localhost:58349/tests/v8_7/run.html (next: http://localhost:58349/tests/v8_7/run.html) 16:05:35 INFO - PROCESS | 15863 | RSS: Main: 147382272 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | __start_tp_report 16:05:35 INFO - PROCESS | 15863 | _x_x_mozilla_page_load 16:05:35 INFO - PROCESS | 15863 | _x_x_mozilla_page_load_details 16:05:35 INFO - PROCESS | 15863 | |i|pagename|runs| 16:05:35 INFO - PROCESS | 15863 | |0;Richards;166.22340425531914 16:05:35 INFO - PROCESS | 15863 | |1;DeltaBlue;191.35093761959433 16:05:35 INFO - PROCESS | 15863 | |2;Encrypt;282.88543140028287 16:05:35 INFO - PROCESS | 15863 | |3;Decrypt;5218.75 16:05:35 INFO - PROCESS | 15863 | |4;RayTrace;1061.5711252653928 16:05:35 INFO - PROCESS | 15863 | |5;Earley;712.7583749109052 16:05:35 INFO - PROCESS | 15863 | |6;Boyer;12345.67901234568 16:05:35 INFO - PROCESS | 15863 | |7;RegExp;25275 16:05:35 INFO - PROCESS | 15863 | |8;Splay;691.8325326012355 16:05:35 INFO - PROCESS | 15863 | |9;NavierStokes;4830.917874396136 16:05:35 INFO - PROCESS | 15863 | __end_tp_report 16:05:35 INFO - PROCESS | 15863 | __startTimestamp1451001935725__endTimestamp 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | ------- Summary: start ------- 16:05:35 INFO - PROCESS | 15863 | Number of tests: 10 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 166.2 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#1] DeltaBlue Cycles:1 Average:191.35 Median:191.35 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 191.4 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 282.9 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 5218.8 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 1061.6 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#5] Earley Cycles:1 Average:712.76 Median:712.76 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 712.8 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 12345.7 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 25275.0 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#8] Splay Cycles:1 Average:691.83 Median:691.83 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 691.8 16:05:35 INFO - PROCESS | 15863 | 16:05:35 INFO - PROCESS | 15863 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:05:35 INFO - PROCESS | 15863 | Values: 4830.9 16:05:35 INFO - PROCESS | 15863 | -------- Summary: end -------- 16:05:35 INFO - PROCESS | 15863 | 16:05:36 INFO - TEST-INFO | 15863: exit 0 16:05:36 INFO - TEST-OK | v8_7 | took 39861ms 16:05:36 INFO - SUITE-END | took 1209s 16:05:36 INFO - Completed test suite (00:20:09) 16:05:36 INFO - Working with test: dromaeo_css 16:05:36 INFO - Generating results file: dromaeo_css 16:05:36 INFO - Working with test: kraken 16:05:36 INFO - Generating results file: kraken 16:05:36 INFO - javascript benchmark 16:05:36 INFO - Working with test: v8_7 16:05:36 INFO - Generating results file: v8_7 16:05:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:05:36 INFO - process_Request line: dromaeo_css 6976.33 graph.html#tests=[[72,63,43]] 16:05:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:37 INFO - process_Request line: kraken 1526.30 graph.html#tests=[[232,63,43]] 16:05:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:05:37 INFO - process_Request line: v8_7 21018.80 graph.html#tests=[[230,63,43]] 16:05:37 INFO - RETURN: dromaeo_css: 6976.33 16:05:37 INFO - RETURN: kraken: 1526.30 16:05:37 INFO - RETURN: v8_7: 21018.80 16:05:37 INFO - javascript benchmark 16:05:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3091.8608662610186, 3148.5277208418734, 3179.793313434628, 3202.0553936588717, 3207.791493552919, 5074.517920797518, 5175.560077393421, 5179.4561571035065, 5189.870253243666, 5226.398964119127, 5092.541671249587, 5101.107306221405, 5111.2333150027425, 5200.765965531551, 5204.713740744258, 4752.287156926463, 4808.326834243208, 4811.30236115763, 4860.222364421693, 4880.585150262232, 4549.636029117679, 4831.975840120795, 4842.152623290927, 4858.271259311096, 4929.975350123263, 4604.654650901179, 4678.6491013174145, 4695.812167513295, 4726.700157456709, 4770.403699537558, 4719.126961512131, 4728.929066064012, 4739.73931433771, 4758.00081982784, 4778.139934811733, 4698.412698412699, 4701.576858082789, 4711.646626502992, 4718.292256161569, 4743.691660042086, 4864.854054378375, 4897.559219670246, 4898.853034408973, 4916.729579873106, 4963.478834722375, 5476.67139971603, 5487.176923461513, 5490.862728431821, 5509.944900550983, 5617.38208797032, 5529.170624406372, 5571.8607034824045, 5587.357453892813, 5607.551395888319, 5634.9857025735355, 5171.146760784466, 5183.196604526304, 5191.5846732261325, 5195.922061169085, 5236.423993360727, 5472.835814925558, 5570.248016517799, 5638.520725738358, 5687.886242275132, 5760.942390576124, 5473.8357849264585, 5483.835484935458, 5485.17722341644, 5487.945120548823, 5495.477929596682, 5480.095784195642, 5522.30971128609, 5522.779088836482, 5549.112142057252, 5579.163125531203, 5452.318460192476, 5455.672659640434, 5547.41752116022, 5547.472990065938, 5550.389457159709, 5476.397596264408, 5508.0, 5551.805686800943, 5574.58190635704, 5617.8033768817895, 4271.594198551133, 4277.337012763027, 4277.850275240352, 4296.377025331372, 4312.353147027971, 3796.734228603971, 3846.807659617008, 3854.479645247912, 3888.4556162137324, 3892.5328960524917, 5206.062908676475, 5240.842774716764, 5257.474252574789, 5262.894742105136, 5313.203019547099, 5471.452854714496, 5501.312335958005, 5502.0921547944945, 5507.697076660742, 5562.415946325658, 5127.615428842777, 5156.278121063054, 5191.948080519146, 5192.143296356059, 5228.55557277628, 4826.276058591239, 4826.8793280168275, 4829.420469543677, 4846.39420072491, 4854.320395144682, 5584.748686309126, 5589.55283577321, 5598.524125449301, 5619.662820230799, 5634.464725850956, 5422.6475279106735, 5462.617616766788, 5564.777408903598, 5576.525995290446, 5669.574781891457, 5597.944020559742, 5612.579056570855, 5629.043062679436, 5632.042552766122, 5632.5775566831835, 5478.233047373451, 5490.121580547253, 5504.944950550604, 5507.173923911285, 5552.000639884859, 5409.918851217313, 5502.752376143003, 5522.6134170609275, 5528.917066243929, 5532.944670553404, 5363.570914326767, 5367.758450869642, 5397.055515284731, 5478.91781623268, 5519.061759500814, 5382.085045542189, 5382.542483888913, 5384.084705599979, 5392.325959255093, 5410.621256512007, 5184.222366644883, 5311.389190243017, 5315.3090098286975, 5320.840374788762, 5324.520793128637, 5362.1420572708175, 5408.621396502207, 5424.511793938565, 5425.891482170414, 5433.755481003285, 5303.124984377689, 5327.3074500314715, 5336.146216605324, 5423.023855706011, 5459.617826752089], "unit": "score", "name": "dojo.html", "value": 5110.238443549528}, {"lowerIsBetter": false, "replicates": [558.8686658635222, 560.5655616896904, 561.0938334589638, 561.7219476359201, 564.3904583050305, 35512.467312990295, 35946.820265898634, 36007.819960900226, 36072.63927360729, 36156.27687446253, 37846.43230351547, 38098.42852357217, 38328.80835595825, 38447.23105537888, 38507.61492385082, 8399.790005249857, 8639.568021598927, 8643.394962352639, 8644.697435589756, 8685.174908383726, 8344.457610255315, 8479.152084791502, 8492.53291068991, 8673.04596494385, 8758.824823503526, 8672.0, 8749.16882896124, 8759.912400875974, 8768.561571921411, 8778.0, 8572.399932004762, 8626.094260102662, 8627.137286271385, 8699.869501957475, 8715.346349023785, 8551.444156129894, 8571.485710857369, 8707.956460217722, 8708.695195668184, 8710.259627931633, 35860.28279434397, 36696.26607467836, 36704.632953670385, 36716.63283367159, 36800.44799328012, 3065.509518477033, 3078.4458797416455, 3111.20664230622, 3295.423300922329, 3352.8155951422664, 28767.280817979718, 28844.42311153786, 29451.11646650604, 29685.406291874042, 30109.247268818235, 3777.1501412182315, 3857.9807100964595, 3865.7873816940055, 3870.845166193349, 3940.251352243093, 264688.6765566179, 264979.0, 266253.0, 267633.0, 269259.0, 51985.7400712994, 52499.21251181235, 58743.4125658738, 59120.0, 59222.0, 58949.705251474326, 59959.40040599625, 59980.100298495556, 60034.0977836448, 60456.0, 14757.77863332051, 14779.33492992818, 14795.0, 14875.404983800743, 14884.553463396116, 11212.27120237182, 11231.382273974847, 11260.774784504429, 11264.155188360906, 11278.041366483776, 19441.61116777685, 19847.60304793896, 19887.60224795496, 19888.801111988985, 19922.800771992384, 7923.524588524707, 8010.239027292398, 8054.436189466798, 8098.919010809816, 8099.109097999215, 922.5202894494826, 999.3254553176722, 1005.5726316315537, 1063.1919740996743, 1066.8773091094467, 27540.173794786187, 27651.58522622162, 27744.583831242144, 28024.71975280221, 28093.0, 999.3354419311077, 1009.5154325923597, 1031.0874875735028, 1039.6828967165088, 1094.2176343914139, 14400.135991840523, 14483.710325793425, 14664.926675366554, 14842.332095055748, 14845.703085938438, 312198.0, 314299.0, 315607.0, 315952.0, 316583.0, 49088.0, 49554.75222623936, 49733.25400119001, 50008.74995624999, 50200.0, 1310.33173081729, 1318.7032917593465, 1327.422571181539, 1328.6479083043002, 1333.4732780551822, 26507.33731656724, 27354.0, 27408.725912741415, 27605.86197069082, 27655.861720691268, 43879.122417552106, 44374.3343849849, 44375.556244438434, 44387.778061109486, 44603.77698111489, 238250.0, 240974.0, 242880.0, 243377.0, 245116.0, 31944.201394965312, 41280.38079428871, 41496.79251603843, 41815.1636967265, 41883.1623367537, 38673.22653546857, 38683.41974870436, 39565.0, 39871.60128398679, 40044.399334010595, 32190.0, 32758.181045474055, 32958.835205823816, 37297.6270237305, 38458.80770596129, 35292.64707352893, 35610.0, 35901.28197436089, 36022.0, 36624.08439789026, 34813.82593087018, 34872.65127348694, 34928.126796830285, 35404.64595354014, 35428.29143417169, 30959.226019348796, 32153.356932860745, 32393.0, 32589.0, 32819.34361312808, 24771.62842557327, 24796.628050579617, 24810.751892480843, 24866.378340541632, 25299.367515812253], "unit": "score", "name": "ext.html", "value": 18036.004917773906}, {"lowerIsBetter": false, "replicates": [358.85107680312655, 364.1715098151706, 365.38979903561057, 367.37546171508444, 368.60927416938046, 11237.83143252852, 11667.12496562759, 16189.83810161898, 17016.829831701696, 17789.822101778962, 17699.1150442478, 17702.734458983126, 17806.0, 17967.460976170736, 17986.28054877803, 5787.739551720172, 5902.527797776168, 5928.525717942576, 5953.613015154023, 5954.255718035246, 5318.228856815759, 5940.138679891413, 5988.520918326523, 6021.337652858182, 6021.698915054251, 5937.37657545958, 5979.1629171915965, 5985.191999080133, 5992.131140984577, 6000.639961602296, 5818.156367326714, 5945.672987985659, 5973.104034394853, 6068.362821903725, 6071.392860713893, 5837.9124313135335, 5839.357670656224, 5839.970800145972, 5848.4151584841175, 5856.736446859902, 22260.226301032122, 22298.554028919494, 22593.2092376766, 23263.18578849749, 23594.410139746473, 2175.140819376353, 2227.1982086448866, 2245.1019592163266, 2365.8225633077586, 2625.5930330798756, 14321.140731556035, 14565.198914059829, 14722.779158312635, 14872.776908346275, 14902.70194596113, 1930.5945751392223, 2011.8189362957405, 2027.9695804562944, 2048.774634790172, 2049.11887888208, 62258.0, 67311.66344168296, 68103.0, 68454.31545684529, 68605.65697171532, 15178.241087945558, 15547.0, 15594.454194103151, 15616.219189040503, 15642.921785391, 13003.934980325037, 13131.277779722015, 13341.733165336638, 23922.0, 23941.401464963514, 7110.537815042006, 7189.352958233784, 7251.311125443074, 7271.309225623558, 7294.9270507295305, 7005.824854378681, 7160.856782864314, 7194.748183813542, 7228.421726261887, 7378.96310518444, 4527.411436513298, 4545.568171023748, 4601.792919318638, 4604.769761511911, 4625.791839367236, 1832.3128826689992, 1908.6469003234447, 1911.1972971352066, 1932.1981377728086, 1955.0, 941.5668792355593, 948.6489998700525, 965.0976337124811, 965.2471072563412, 1001.3791449301334, 15040.097594144387, 16450.259738311805, 16742.497725068268, 16879.493615191564, 17931.73102403465, 908.8046070094962, 909.554318383987, 942.1661829281136, 952.228694757235, 958.4297343080996, 9533.618655253713, 9950.0, 9972.351797133164, 10022.372702313489, 10030.548625311878, 533375.0, 533773.6556586117, 540150.0, 555331.0, 559619.0, 40582.59417405788, 40798.38802417966, 71223.93164102543, 78524.0, 81288.18711812925, 1134.211722852626, 1137.954481820718, 1147.4492243722893, 1148.0700632487878, 1148.2478976270556, 15261.0, 15477.452254774882, 15505.534833955, 15633.530994070195, 15639.452619158275, 31192.688073118978, 35013.824930875184, 35185.824070879484, 35549.111272217364, 36482.452763209105, 41998.37002444905, 42459.36310955277, 42805.78597107119, 46651.76674116608, 47643.76178119087, 9033.90966090357, 9341.813163736551, 9395.530223488935, 9440.197583205505, 9682.75793105178, 10743.570257189625, 10931.945340273247, 10963.0, 15778.605534861721, 17016.23426945766, 14105.435782568582, 14337.139771613736, 14407.351669175121, 14482.493112741004, 14872.62818429548, 14330.283485825876, 14688.192149431883, 14730.631734206301, 14862.702745945237, 15105.244737762849, 14373.425062997363, 14449.0, 15037.774433383289, 15155.772663410278, 15651.139187344805, 9439.386439881386, 9648.75878103053, 9717.0, 9725.41647501124, 9754.12212900814, 10450.68647940563, 13102.541411050568, 14341.498047568284, 14602.342894569558, 15101.848981510044], "unit": "score", "name": "jquery.html", "value": 9261.559961877885}, {"lowerIsBetter": false, "replicates": [1378.1799829101685, 1415.3984556563457, 1551.177875725865, 1751.0806826416122, 1780.6883795335814, 7186.281371862811, 7287.927120728805, 7422.3690986266165, 7534.284242996913, 7565.3947684185205, 7459.142198647157, 7460.440466964972, 7543.585102819343, 7551.28262815033, 7551.962240188791, 2198.7251593550845, 2231.966520502194, 2236.9217077402295, 2239.988800055997, 2251.986606027286, 2220.467087898901, 2244.7306323241232, 2288.1762565476415, 2288.6567014947723, 2288.771122887706, 2152.397328747953, 2193.5283913958574, 2198.6372248578964, 2212.723409573803, 2215.7341119065654, 2201.152556265833, 2215.3575463115676, 2244.236959433792, 2250.3586477853733, 2259.627161518356, 2226.343228747507, 2250.774922507736, 2251.2008237075765, 2251.6960210371553, 2261.6155253606926, 7322.853542929165, 7443.516171448892, 7490.250974902466, 7492.812679682997, 7499.362554182846, 4467.508574056851, 4553.886152846206, 4586.839460618896, 4612.0, 4622.976885115587, 2930.150256425634, 3020.018493989462, 3041.7870749047574, 3043.680413556589, 3058.189579761365, 970.4856426094182, 973.0123924216925, 999.8150342186646, 1005.4620777883797, 1025.5743866295552, 9921.156701680366, 9930.553125109387, 9965.053319934595, 9978.451185184811, 10106.797864042677, 3974.1455587048345, 3983.143624120828, 4009.0979529605606, 4035.6973227008093, 4128.896777580585, 8212.425130240945, 8227.917720822836, 8278.917210827934, 8280.04779450359, 8310.750677479686, 4485.865424037284, 4529.071540334224, 4534.0478499515475, 4541.182587134347, 4544.454665440168, 4192.874213773592, 4199.517055538591, 4209.6000879916355, 4221.957780422156, 4236.046889449911, 3347.4811404232382, 3367.2087059540986, 3371.2077661749468, 3380.4253276942977, 3410.2838403935452, 1067.9145668346514, 1072.1797824664138, 1076.2520048566328, 1077.590515604081, 1082.9133669306436, 931.3852857114407, 951.9333646644668, 1100.9815920273716, 1150.4017910686396, 1347.0, 6719.832004199934, 6742.190937087581, 6779.593224406552, 6817.250102488722, 6819.454443644497, 1171.800793865045, 1198.2870192235605, 1218.2020776391478, 1219.7682440336307, 1222.7684475831643, 5485.369182543979, 5542.3626282977975, 5548.833534993957, 5549.250851135045, 5555.611107222537, 8287.62705678246, 8339.166083391612, 8579.399442038997, 8633.0, 8662.393632445668, 8474.237318641228, 8474.237318641228, 8544.060153383123, 8594.312455003585, 8687.478751274944, 7101.502894797418, 7110.57336559808, 7146.571205727673, 7190.712371505186, 7274.018007569016, 6909.239983601699, 6911.205211400753, 6914.585124892523, 6915.550489218184, 6952.0, 7937.563434010954, 7987.400944929037, 8106.83786324282, 8189.79525511867, 8200.0, 8141.633626486704, 8284.420090593601, 8285.378596605158, 8296.70961516344, 8300.252977232078, 6370.203724534434, 6379.234491861006, 6415.230172379344, 6444.9355506444335, 6502.934970650233, 7263.782086537412, 7313.414926805736, 7324.340809327186, 7339.486235963432, 7372.336489715737, 6747.325267473213, 6851.48613853953, 7056.858862822817, 7067.82330441743, 7171.713131474683, 6533.934660653333, 6551.967240163769, 6555.672216389257, 6645.136132302963, 6753.797386078426, 6334.303226645157, 6437.613743175424, 6476.0933469313395, 6504.804855854332, 6518.511111666549, 6079.300880398634, 6092.055731361646, 6093.055576385667, 6135.325114237341, 6141.293751218488, 6112.083187521907, 6180.969095154495, 6203.379662033941, 6218.036204388327, 6236.18929539157], "unit": "score", "name": "mootools.html", "value": 4315.611564959022}, {"lowerIsBetter": false, "replicates": [341.9179396944733, 346.31084142556307, 349.94400895856666, 355.60527814126317, 356.41192033145325, 6167.753289868406, 6213.440790328869, 6231.719572619231, 6237.750489980401, 6322.9051564226575, 6220.906686399708, 6276.748930042804, 6291.1821463209835, 6293.811185664426, 6301.527385446087, 4763.380760501139, 4764.547368000034, 4768.356271903301, 4776.47458779534, 4780.832670856521, 4774.546418090275, 4776.235802271637, 4779.402574678165, 4790.688605240648, 4791.904161916759, 4607.58531732144, 4700.929486057712, 4705.3647757552635, 4718.787654555536, 4742.928856067162, 4698.835540756091, 4711.0, 4713.316569097462, 4739.881502962419, 4743.501932297094, 4152.750834949913, 4154.979225103885, 4155.293600087993, 4162.5629308922735, 4165.66674666026, 5929.436703513159, 5969.761209551612, 5973.342932277446, 5978.282606087254, 5978.521718262528, 5369.7583608737705, 5519.282493275889, 5528.9723551381985, 5529.225908372831, 5540.695261760601, 6597.241317248529, 6604.787396222271, 6609.801705948781, 6613.371729685672, 6616.900746488806, 4552.408186935677, 4552.908941821145, 4565.931511027337, 4568.200564901129, 4587.931181032287, 6811.318868113149, 6858.931410685879, 6914.101166848328, 6938.514303998722, 6959.965200173967, 4676.134915040729, 4683.227267500893, 4683.625309975194, 4692.554207350297, 4693.601043911238, 4745.738984355894, 4758.738269395217, 4759.976200118977, 4762.8333008345235, 4766.451858036301, 5444.40111587725, 5475.0418676731415, 5503.422140675251, 5512.0, 5519.0, 6422.903656445157, 6604.372584604551, 6605.636689982097, 6626.602403855784, 6640.83397915056, 1632.3062698353153, 1659.9170041497878, 1688.1643586424798, 1689.1047744695331, 1689.932402703878, 1119.0991252042184, 1119.138263537072, 1134.4554613785429, 1135.1883403366633, 1136.1933027550367, 6199.845003874939, 6242.781502647385, 6244.500439964882, 6252.406021427957, 6265.0, 6731.932680673229, 6782.626955517395, 6809.795706128824, 6821.420179284717, 6826.590404575642, 6069.302030266487, 6190.195274614362, 6224.502039836802, 6228.626282423069, 6237.282712488031, 3647.1429214134655, 3649.5255616770182, 3664.212194378168, 3670.3026424979703, 3671.5227020487164, 6788.558743681645, 6842.04211410403, 6859.2454829968665, 6867.0, 6878.415334696607, 6795.1845778506895, 6892.138482689664, 6973.05863708403, 6995.685194166274, 7034.015237866703, 6811.182658081062, 6870.31296870319, 6874.553154044971, 6876.621785801729, 6892.724291028403, 6740.955151951455, 6747.055412242388, 6804.55770374924, 6814.4548436124, 6815.727370905108, 6636.402723754885, 6709.597424154566, 6721.260661327348, 6725.226598941184, 6726.697298621476, 7005.789826305219, 7039.296070392919, 7045.11936007999, 7054.964725176341, 7065.1521817382245, 4684.063187362473, 4694.413198350207, 4704.50602686713, 4712.0, 4716.339712440193, 6757.3242675732035, 6934.375906168469, 6941.548799328028, 6971.965140174267, 6975.476839236976, 6688.197416310074, 6723.5293529452465, 6748.257691654012, 6758.695858686273, 6775.762848300285, 6726.697298621476, 6742.595444273359, 6744.69648865812, 6745.898811517929, 6758.628275444898, 6470.676466176767, 6611.735530578915, 6622.569532980341, 6625.105610742488, 6625.966870165811, 6774.762883299061, 6781.89827152603, 6786.423154031765, 6791.898121528082, 6796.252412234551, 6579.605223686594, 6587.868242635216, 6591.307912669293, 6616.470682345497, 6633.900491492535], "unit": "score", "name": "prototype.html", "value": 4985.749921554762}, {"lowerIsBetter": false, "replicates": [846.4208631304639, 849.6049337058269, 850.6724910909298, 866.7443104284232, 882.5013867165047, 12567.0, 12808.48766049358, 13843.861561384396, 13972.37124329405, 13982.510612128577, 12819.423125959354, 12842.52310984237, 12855.550055748028, 12872.806907896389, 12899.38757655293, 794.3843521271018, 822.1408627983772, 824.6536454689045, 824.9628766705482, 826.8511667899776, 809.7611204694629, 832.3133414932674, 832.7918020494876, 833.1168960901433, 834.64110432514, 860.5095095795399, 868.8653258744905, 869.7738587967142, 870.7648934787603, 872.4067634008871, 856.5845564901018, 859.7721603775004, 861.0958493581745, 862.5169904853271, 863.6804382378498, 636.4685487617845, 638.8339031851706, 639.3063526074216, 640.5132099604288, 642.881067002606, 12778.361081945866, 12797.360131993457, 12869.485220591165, 13011.0, 13045.282509461977, 11279.830802537968, 11513.366764827932, 11612.18714689972, 12168.695782605417, 12297.0, 10143.644972426004, 10259.897401025968, 10299.17606591471, 10310.278280520291, 10624.575016999312, 3583.4445660922597, 3607.4769158472136, 3622.3479773640734, 3626.4016437287814, 3727.5340582427198, 46963.29555056677, 47458.05083898337, 47596.52403475955, 47776.0, 48155.75922120402, 9435.339526233234, 9653.517324133905, 9653.951730241304, 9726.262696466354, 9870.25973052024, 17637.382691605733, 17692.734608980874, 17719.114044297734, 17748.467545973643, 17752.20115094824, 7264.309890560388, 7381.0, 7439.739609113655, 7545.7358992435, 7618.885716714254, 4143.3370660694145, 4238.470191226097, 4240.6395456385935, 4278.144371125787, 4283.2932566126865, 2864.7135286471184, 2867.5842002909462, 2896.739293463598, 2897.5943367928508, 2898.7970842040854, 532.5393534592549, 539.029746456377, 544.9373322067934, 544.9673019618835, 546.66926509462, 563.4337490821698, 649.9415052645285, 663.1644128398157, 665.069439611901, 703.5356664601338, 7989.840203195903, 8644.481331120152, 8864.185693453976, 8885.0, 9034.412763170372, 659.9505037122235, 663.2505269045947, 698.4691634357823, 701.3547536266647, 704.0405590735514, 3955.4264631628253, 3993.92012159761, 4009.8195581198916, 4103.466549348565, 4153.439285696452, 54099.0, 54238.457615423344, 54503.45496544984, 54513.0, 56404.435955640736, 47889.0, 49148.75425622921, 49928.75035624798, 50907.181961353046, 51004.74497627488, 44336.669899903696, 44788.55211447909, 45290.54709452929, 45806.0, 46315.536844631126, 8038.115807261313, 8107.83784324322, 8303.626336814737, 8379.832403351777, 8402.41183117176, 33078.834605826814, 33227.16932076718, 34222.31555368829, 34468.0, 36592.81703591465, 42728.78635606802, 42897.785511072245, 43146.784266078466, 43925.0, 44415.77792111148, 10775.92240775916, 11080.5567777288, 11169.944150279196, 11315.0, 11449.6149983262, 12164.5438795329, 12192.329421881881, 12297.200681955645, 12395.566155184526, 12592.307423091817, 11091.833622495831, 11370.20408571392, 11381.487833047368, 11434.71413214643, 11746.353950532803, 11317.490712917774, 11441.084713223088, 11764.88235117672, 11828.46771895284, 12201.51193952232, 11196.272242304223, 11350.0, 11351.0, 11644.301341919512, 12182.39088045612, 9561.808763824823, 9580.856287155559, 9713.36863103896, 9734.172595329477, 10193.23550733683, 8899.955500222457, 9085.409448385833, 9658.275629327689, 9728.708138755848, 10334.173266138541], "unit": "score", "name": "yui.html", "value": 6276.018194292408}], "name": "dromaeo_css", "value": 6976.329896847447}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 111.0, 111.0, 114.0, 123.0, 111.0, 114.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 156.0, 162.0, 126.0, 153.0, 158.0, 124.0, 157.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 163.0, 161.0, 161.0, 161.0, 162.0, 163.0, 175.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 72.0, 73.0, 70.0, 72.0, 138.0, 74.0, 77.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 99.0, 96.0, 96.0, 155.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 62.0, 65.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 62.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 88.0, 87.0, 94.0, 86.0, 87.0, 93.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 121.0, 125.0, 126.0, 125.0, 127.0, 123.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [141.0, 155.0, 164.0, 154.0, 158.0, 151.0, 152.0, 151.0, 151.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 69.0, 67.0, 70.0, 67.0, 73.0, 67.0, 73.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1526.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [191.35093761959433], "unit": "score", "name": "DeltaBlue", "value": 345.53266799999994}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [712.7583749109052], "unit": "score", "name": "Earley", "value": 935.0475890000001}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [691.8325326012355], "unit": "score", "name": "Splay", "value": 117.79006646825394}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21018.800169692382}]} 16:05:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21018.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6976.33"}}} 16:05:37 INFO - Return code: 0 16:05:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:05:37 INFO - # TBPL SUCCESS # 16:05:37 INFO - Running post-action listener: _resource_record_post_action 16:05:37 INFO - Running post-run listener: _resource_record_post_run 16:05:38 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559804416; Read time: 16; Write time: 549312 16:05:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235307008; Read time: 0; Write time: 313628 16:05:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324497408; Read time: 16; Write time: 235684 16:05:38 INFO - Running post-run listener: _upload_blobber_files 16:05:38 INFO - Blob upload gear active. 16:05:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:05:38 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:05:38 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:05:38 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:05:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:39 INFO - (blobuploader) - INFO - Done attempting. 16:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:40 INFO - (blobuploader) - INFO - Done attempting. 16:05:40 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:40 INFO - Return code: 0 16:05:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:05:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/973a1a7baaad3ac46aa028e44f781fbea4d1771294db9d5ca4ede9ff4395d74e854b5d12d04137ee9212f98a106b33148b563c555dd440ce30a387e973b78c23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e98f0b67be98fb52fc70e9462077b61012f0cd7492b0cd5b5d0b6961bda7477a1242760456312bf6fccfa90da954126cdbb82c9f93c803cd0b5fb98b39b0b3"} 16:05:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:05:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:05:40 INFO - Contents: 16:05:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/973a1a7baaad3ac46aa028e44f781fbea4d1771294db9d5ca4ede9ff4395d74e854b5d12d04137ee9212f98a106b33148b563c555dd440ce30a387e973b78c23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e98f0b67be98fb52fc70e9462077b61012f0cd7492b0cd5b5d0b6961bda7477a1242760456312bf6fccfa90da954126cdbb82c9f93c803cd0b5fb98b39b0b3"} 16:05:40 INFO - Copying logs to upload dir... 16:05:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.515708 ========= master_lag: 40.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-12-24 16:06:19.794439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:19.798625) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/973a1a7baaad3ac46aa028e44f781fbea4d1771294db9d5ca4ede9ff4395d74e854b5d12d04137ee9212f98a106b33148b563c555dd440ce30a387e973b78c23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e98f0b67be98fb52fc70e9462077b61012f0cd7492b0cd5b5d0b6961bda7477a1242760456312bf6fccfa90da954126cdbb82c9f93c803cd0b5fb98b39b0b3"} build_url:https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/B2RJVoL2QOifsSkDKWRdlw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/973a1a7baaad3ac46aa028e44f781fbea4d1771294db9d5ca4ede9ff4395d74e854b5d12d04137ee9212f98a106b33148b563c555dd440ce30a387e973b78c23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/43e98f0b67be98fb52fc70e9462077b61012f0cd7492b0cd5b5d0b6961bda7477a1242760456312bf6fccfa90da954126cdbb82c9f93c803cd0b5fb98b39b0b3"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 16:06:19.969377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 16:06:19.969672) ========= 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-1450999900.95860-285059883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 1.49 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 16:06:21.463669) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 16:06:21.464004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 16:06:21.583366) ========= ========= Total master_lag: 41.90 =========