builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1453236758.19 results: success (0) buildid: 20160119103123 builduid: 8671b47b99da4546a042284c050e200d revision: 94084e465160718075338e2e9e1ce6d04033237d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.192157) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.192782) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.193241) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006399 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.219922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.220233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.235107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.235695) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.287868) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.288167) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.288604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.288912) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 12:52:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.3M=0s 2016-01-19 12:52:39 (96.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.442012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.442352) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022487 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.492010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:38.492354) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 94084e465160718075338e2e9e1ce6d04033237d --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 94084e465160718075338e2e9e1ce6d04033237d --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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 12:52:39,784 truncating revision to first 12 chars 2016-01-19 12:52:39,784 Setting DEBUG logging. 2016-01-19 12:52:39,784 attempt 1/10 2016-01-19 12:52:39,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/94084e465160?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 12:52:40,031 unpacking tar archive at: mozilla-inbound-94084e465160/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.031638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.031968) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004666 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.088749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.089058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.099258) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.099572) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 12:52:39.100192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-19 12:52:39.100993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --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', '--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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:52:40 INFO - MultiFileLogger online at 20160119 12:52:40 in /builds/slave/test-pgo 12:52:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:52:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:52:40 INFO - {'append_to_log': False, 12:52:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:52:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:52:40 INFO - 'branch': 'Mozilla-Inbound', 12:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:40 INFO - 'config_files': ('talos/linux_config.py',), 12:52:40 INFO - 'default_actions': ('clobber', 12:52:40 INFO - 'read-buildbot-config', 12:52:40 INFO - 'download-and-extract', 12:52:40 INFO - 'populate-webroot', 12:52:40 INFO - 'create-virtualenv', 12:52:40 INFO - 'install', 12:52:40 INFO - 'run-tests'), 12:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:40 INFO - 'download_minidump_stackwalk': True, 12:52:40 INFO - 'download_symbols': 'ondemand', 12:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:40 INFO - 'installer_path': 'installer.exe', 12:52:40 INFO - 'log_level': 'info', 12:52:40 INFO - 'log_name': 'talos', 12:52:40 INFO - 'log_to_console': True, 12:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:52:40 INFO - 'opt_config_files': (), 12:52:40 INFO - 'pip_index': False, 12:52:40 INFO - 'sps_profile': False, 12:52:40 INFO - 'sps_profile_interval': 0, 12:52:40 INFO - 'suite': 'dromaeojs-e10s', 12:52:40 INFO - 'system_bits': '32', 12:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:40 INFO - 'title': 'talos-linux64-ix-010', 12:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:40 INFO - 'use_talos_json': True, 12:52:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:40 INFO - 'work_dir': 'build'} 12:52:40 INFO - ##### 12:52:40 INFO - ##### Running clobber step. 12:52:40 INFO - ##### 12:52:40 INFO - Running pre-action listener: _resource_record_pre_action 12:52:40 INFO - Running main action method: clobber 12:52:40 INFO - rmtree: /builds/slave/test-pgo/build 12:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:52:41 INFO - Running post-action listener: _resource_record_post_action 12:52:41 INFO - ##### 12:52:41 INFO - ##### Running read-buildbot-config step. 12:52:41 INFO - ##### 12:52:41 INFO - Running pre-action listener: _resource_record_pre_action 12:52:41 INFO - Running main action method: read_buildbot_config 12:52:41 INFO - Using buildbot properties: 12:52:41 INFO - { 12:52:41 INFO - "project": "", 12:52:41 INFO - "product": "firefox", 12:52:41 INFO - "script_repo_revision": "production", 12:52:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:52:41 INFO - "repository": "", 12:52:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:52:41 INFO - "buildid": "20160119103123", 12:52:41 INFO - "pgo_build": "True", 12:52:41 INFO - "basedir": "/builds/slave/test-pgo", 12:52:41 INFO - "buildnumber": 636, 12:52:41 INFO - "slavename": "talos-linux64-ix-010", 12:52:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:52:41 INFO - "platform": "ubuntu64_hw", 12:52:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:52:41 INFO - "branch": "mozilla-inbound", 12:52:41 INFO - "repo_path": "integration/mozilla-inbound", 12:52:41 INFO - "revision": "94084e465160718075338e2e9e1ce6d04033237d", 12:52:41 INFO - "stage_platform": "linux64-pgo", 12:52:41 INFO - "builduid": "8671b47b99da4546a042284c050e200d", 12:52:41 INFO - "slavebuilddir": "test" 12:52:41 INFO - } 12:52:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:52:41 INFO - Running post-action listener: _resource_record_post_action 12:52:41 INFO - ##### 12:52:41 INFO - ##### Running download-and-extract step. 12:52:41 INFO - ##### 12:52:41 INFO - Running pre-action listener: _resource_record_pre_action 12:52:41 INFO - Running main action method: download_and_extract 12:52:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:52:41 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')]} 12:52:41 INFO - https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/test_packages.json 12:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/test_packages.json 12:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:52:42 INFO - Downloaded 1448 bytes. 12:52:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:52:42 INFO - Using the following test package requirements: 12:52:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:52:42 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:52:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'jsshell-linux-x86_64.zip'], 12:52:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:52:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:52:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:52:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:52:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:52:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:42 INFO - https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:43 INFO - Downloaded 22484574 bytes. 12:52:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:52:45 INFO - Return code: 0 12:52:45 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 12:52: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')]} 12:52:45 INFO - https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:47 INFO - Downloaded 22484574 bytes. 12:52:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:52:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:52:48 INFO - Return code: 0 12:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:48 INFO - https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:49 INFO - Downloaded 11132144 bytes. 12:52:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:52:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:52:50 INFO - Return code: 0 12:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:50 INFO - https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FMtslBbJTTWqH4fSX_oe_g/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 12:52:51 INFO - Downloaded 55930830 bytes. 12:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:52:51 INFO - mkdir: /builds/slave/test-pgo/properties 12:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:52:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:52:51 INFO - Contents: 12:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:52:51 INFO - Running post-action listener: _resource_record_post_action 12:52:51 INFO - Running post-action listener: set_extra_try_arguments 12:52:51 INFO - ##### 12:52:51 INFO - ##### Running populate-webroot step. 12:52:51 INFO - ##### 12:52:51 INFO - Running pre-action listener: _resource_record_pre_action 12:52:51 INFO - Running main action method: populate_webroot 12:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:51 INFO - '--tppagecycles', 12:52:51 INFO - '7'], 12:52:51 INFO - 'tests': ['tsvgm']}}, 12:52:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:52:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:52:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['damp', 'tps']}, 12:52:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['damp', 'tps']}, 12:52:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:51 INFO - 'other': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other_l64': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'other_nol64': {'tests': ['a11yr', 12:52:51 INFO - 'ts_paint', 12:52:51 INFO - 'tpaint', 12:52:51 INFO - 'sessionrestore', 12:52:51 INFO - 'sessionrestore_no_auto_restore']}, 12:52:51 INFO - 'svgr': {'tests': ['tsvgx', 12:52:51 INFO - 'tsvgr_opacity', 12:52:51 INFO - 'tart', 12:52:51 INFO - 'tscrollx', 12:52:51 INFO - 'cart']}, 12:52:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tsvgx', 12:52:51 INFO - 'tsvgr_opacity', 12:52:51 INFO - 'tart', 12:52:51 INFO - 'tscrollx', 12:52:51 INFO - 'cart']}, 12:52:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'tests': ['tp5o']}, 12:52:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s'], 12:52:51 INFO - 'tests': ['tp5o']}, 12:52:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--xperf_path', 12:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:51 INFO - 'tests': ['tp5n']}, 12:52:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:51 INFO - 'talos_options': ['--e10s', 12:52:51 INFO - '--xperf_path', 12:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:51 INFO - 'tests': ['tp5n']}}, 12:52:51 INFO - 'talos.zip': {'path': '', 12:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:51 INFO - Running post-action listener: _resource_record_post_action 12:52:51 INFO - ##### 12:52:51 INFO - ##### Running create-virtualenv step. 12:52:51 INFO - ##### 12:52:51 INFO - Running pre-action listener: _resource_record_pre_action 12:52:51 INFO - Running main action method: create_virtualenv 12:52:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:52:51 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 12:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:51 INFO - Using real prefix '/usr' 12:52:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:52:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:54 INFO - Installing pip.................done. 12:52:54 INFO - Return code: 0 12:52:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:52:54 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')]} 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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')]} 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:52:54 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 12:52:54 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 12:52:54 INFO - Using env: {'DISPLAY': ':0', 12:52:54 INFO - 'HOME': '/home/cltbld', 12:52:54 INFO - 'LANG': 'en_US.UTF-8', 12:52:54 INFO - 'LANGUAGE': 'en_US:en', 12:52:54 INFO - 'LOGNAME': 'cltbld', 12:52:54 INFO - 'MAIL': '/var/mail/cltbld', 12:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:54 INFO - 'MOZ_NO_REMOTE': '1', 12:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:54 INFO - 'NO_EM_RESTART': '1', 12:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:54 INFO - 'SHELL': '/bin/bash', 12:52:54 INFO - 'SHLVL': '1', 12:52:54 INFO - 'TERM': 'linux', 12:52:54 INFO - 'TMOUT': '86400', 12:52:54 INFO - 'USER': 'cltbld', 12:52:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:54 INFO - '_': '/tools/buildbot/bin/python'} 12:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:54 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 12:52:54 INFO - Cleaning up... 12:52:54 INFO - Return code: 0 12:52:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:52:54 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')]} 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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')]} 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:54 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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:52:54 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 12:52:54 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 12:52:54 INFO - Using env: {'DISPLAY': ':0', 12:52:54 INFO - 'HOME': '/home/cltbld', 12:52:54 INFO - 'LANG': 'en_US.UTF-8', 12:52:54 INFO - 'LANGUAGE': 'en_US:en', 12:52:54 INFO - 'LOGNAME': 'cltbld', 12:52:54 INFO - 'MAIL': '/var/mail/cltbld', 12:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:54 INFO - 'MOZ_NO_REMOTE': '1', 12:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:54 INFO - 'NO_EM_RESTART': '1', 12:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:54 INFO - 'SHELL': '/bin/bash', 12:52:54 INFO - 'SHLVL': '1', 12:52:54 INFO - 'TERM': 'linux', 12:52:54 INFO - 'TMOUT': '86400', 12:52:54 INFO - 'USER': 'cltbld', 12:52:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:54 INFO - '_': '/tools/buildbot/bin/python'} 12:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:54 INFO - Downloading/unpacking psutil>=0.7.1 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:56 INFO - Installing collected packages: psutil 12:52:56 INFO - Running setup.py install for psutil 12:52:56 INFO - building 'psutil._psutil_linux' extension 12:52:56 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 12:52:56 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 12:52:56 INFO - building 'psutil._psutil_posix' extension 12:52:56 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 12:52:56 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 12:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:56 INFO - Successfully installed psutil 12:52:56 INFO - Cleaning up... 12:52:56 INFO - Return code: 0 12:52:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:52:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:52:56 INFO - Using env: {'DISPLAY': ':0', 12:52:56 INFO - 'HOME': '/home/cltbld', 12:52:56 INFO - 'LANG': 'en_US.UTF-8', 12:52:56 INFO - 'LANGUAGE': 'en_US:en', 12:52:56 INFO - 'LOGNAME': 'cltbld', 12:52:56 INFO - 'MAIL': '/var/mail/cltbld', 12:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:56 INFO - 'MOZ_NO_REMOTE': '1', 12:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:56 INFO - 'NO_EM_RESTART': '1', 12:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:56 INFO - 'SHELL': '/bin/bash', 12:52:56 INFO - 'SHLVL': '1', 12:52:56 INFO - 'TERM': 'linux', 12:52:56 INFO - 'TMOUT': '86400', 12:52:56 INFO - 'USER': 'cltbld', 12:52:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:56 INFO - '_': '/tools/buildbot/bin/python'} 12:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:52:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:52:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:52:58 INFO - Installing collected packages: mozsystemmonitor 12:52:58 INFO - Running setup.py install for mozsystemmonitor 12:52:59 INFO - Successfully installed mozsystemmonitor 12:52:59 INFO - Cleaning up... 12:52:59 INFO - Return code: 0 12:52:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:52:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:52:59 INFO - Using env: {'DISPLAY': ':0', 12:52:59 INFO - 'HOME': '/home/cltbld', 12:52:59 INFO - 'LANG': 'en_US.UTF-8', 12:52:59 INFO - 'LANGUAGE': 'en_US:en', 12:52:59 INFO - 'LOGNAME': 'cltbld', 12:52:59 INFO - 'MAIL': '/var/mail/cltbld', 12:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:59 INFO - 'MOZ_NO_REMOTE': '1', 12:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:59 INFO - 'NO_EM_RESTART': '1', 12:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:59 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:59 INFO - 'SHELL': '/bin/bash', 12:52:59 INFO - 'SHLVL': '1', 12:52:59 INFO - 'TERM': 'linux', 12:52:59 INFO - 'TMOUT': '86400', 12:52:59 INFO - 'USER': 'cltbld', 12:52:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:59 INFO - '_': '/tools/buildbot/bin/python'} 12:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53:01 INFO - Downloading docopt-0.6.1.tar.gz 12:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:01 INFO - Running setup.py install for blobuploader 12:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:53:01 INFO - Running setup.py install for requests 12:53:02 INFO - Running setup.py install for docopt 12:53:02 INFO - Successfully installed blobuploader requests docopt 12:53:02 INFO - Cleaning up... 12:53:02 INFO - Return code: 0 12:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:02 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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:53:02 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 12:53:02 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 12:53:02 INFO - Using env: {'DISPLAY': ':0', 12:53:02 INFO - 'HOME': '/home/cltbld', 12:53:02 INFO - 'LANG': 'en_US.UTF-8', 12:53:02 INFO - 'LANGUAGE': 'en_US:en', 12:53:02 INFO - 'LOGNAME': 'cltbld', 12:53:02 INFO - 'MAIL': '/var/mail/cltbld', 12:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:02 INFO - 'MOZ_NO_REMOTE': '1', 12:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:02 INFO - 'NO_EM_RESTART': '1', 12:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:02 INFO - 'SHELL': '/bin/bash', 12:53:02 INFO - 'SHLVL': '1', 12:53:02 INFO - 'TERM': 'linux', 12:53:02 INFO - 'TMOUT': '86400', 12:53:02 INFO - 'USER': 'cltbld', 12:53:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:02 INFO - '_': '/tools/buildbot/bin/python'} 12:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:02 INFO - Running setup.py (path:/tmp/pip-NOK9rH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:02 INFO - Running setup.py (path:/tmp/pip-9EJBpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:02 INFO - Running setup.py (path:/tmp/pip-0XbbMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:02 INFO - Running setup.py (path:/tmp/pip-rHfBOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:02 INFO - Running setup.py (path:/tmp/pip-8MaFdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:02 INFO - Running setup.py (path:/tmp/pip-tECbew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:03 INFO - Running setup.py (path:/tmp/pip-ccDUXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:03 INFO - Running setup.py (path:/tmp/pip-yYoIBF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:03 INFO - Running setup.py (path:/tmp/pip-NVSIFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:03 INFO - Running setup.py (path:/tmp/pip-Wq0gGq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:03 INFO - Running setup.py (path:/tmp/pip-WutFFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:03 INFO - Running setup.py (path:/tmp/pip-aS9jpb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:03 INFO - Running setup.py (path:/tmp/pip-lsRZCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:03 INFO - Running setup.py (path:/tmp/pip-gfz_rP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:03 INFO - Running setup.py (path:/tmp/pip-XgaJUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:03 INFO - Running setup.py (path:/tmp/pip-smicvG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:03 INFO - Running setup.py (path:/tmp/pip-vdOo8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:03 INFO - Running setup.py install for manifestparser 12:53:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:53:03 INFO - Running setup.py install for mozcrash 12:53:04 INFO - Running setup.py install for mozdebug 12:53:04 INFO - Running setup.py install for mozdevice 12:53:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozfile 12:53:04 INFO - Running setup.py install for mozhttpd 12:53:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozinfo 12:53:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozInstall 12:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozleak 12:53:04 INFO - Running setup.py install for mozlog 12:53:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for moznetwork 12:53:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:53:04 INFO - Running setup.py install for mozprocess 12:53:05 INFO - Running setup.py install for mozprofile 12:53:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozrunner 12:53:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Running setup.py install for mozscreenshot 12:53:05 INFO - Running setup.py install for moztest 12:53:05 INFO - Running setup.py install for mozversion 12:53:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:05 INFO - Cleaning up... 12:53:05 INFO - Return code: 0 12:53:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 12:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 12:53:05 INFO - Using env: {'DISPLAY': ':0', 12:53:05 INFO - 'HOME': '/home/cltbld', 12:53:05 INFO - 'LANG': 'en_US.UTF-8', 12:53:05 INFO - 'LANGUAGE': 'en_US:en', 12:53:05 INFO - 'LOGNAME': 'cltbld', 12:53:05 INFO - 'MAIL': '/var/mail/cltbld', 12:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:05 INFO - 'MOZ_NO_REMOTE': '1', 12:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:05 INFO - 'NO_EM_RESTART': '1', 12:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:05 INFO - 'SHELL': '/bin/bash', 12:53:05 INFO - 'SHLVL': '1', 12:53:05 INFO - 'TERM': 'linux', 12:53:05 INFO - 'TMOUT': '86400', 12:53:05 INFO - 'USER': 'cltbld', 12:53:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:05 INFO - '_': '/tools/buildbot/bin/python'} 12:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:05 INFO - Running setup.py (path:/tmp/pip-n_YKFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:53:05 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)) 12:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:05 INFO - Running setup.py (path:/tmp/pip-13KBYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:53:05 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)) 12:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:05 INFO - Running setup.py (path:/tmp/pip-0KCqXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:06 INFO - Running setup.py (path:/tmp/pip-QAKCKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:06 INFO - Running setup.py (path:/tmp/pip-Xg4ctv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:06 INFO - Running setup.py (path:/tmp/pip-OLzk65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:06 INFO - Running setup.py (path:/tmp/pip-G31lei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:06 INFO - Running setup.py (path:/tmp/pip-pkoKzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:06 INFO - Running setup.py (path:/tmp/pip-12tYG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:06 INFO - Running setup.py (path:/tmp/pip-hxzexK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:06 INFO - Running setup.py (path:/tmp/pip-Jp6hlt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:06 INFO - Running setup.py (path:/tmp/pip-5E6CfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:06 INFO - Running setup.py (path:/tmp/pip-ThFRS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:06 INFO - Running setup.py (path:/tmp/pip-4PU__A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:06 INFO - Running setup.py (path:/tmp/pip-5sdZ8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:53:06 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)) 12:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:06 INFO - Running setup.py (path:/tmp/pip-5ZMvUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:53:07 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)) 12:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:07 INFO - Running setup.py (path:/tmp/pip-i6g6V4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 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)) 12:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:08 INFO - Downloading blessings-1.5.1.tar.gz 12:53:08 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 12:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:08 INFO - Installing collected packages: blessings 12:53:08 INFO - Running setup.py install for blessings 12:53:09 INFO - Successfully installed blessings 12:53:09 INFO - Cleaning up... 12:53:09 INFO - Return code: 0 12:53:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:53:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:09 INFO - Reading from file tmpfile_stdout 12:53:09 INFO - Current package versions: 12:53:09 INFO - argparse == 1.2.1 12:53:09 INFO - blessings == 1.5.1 12:53:09 INFO - blobuploader == 1.2.4 12:53:09 INFO - docopt == 0.6.1 12:53:09 INFO - manifestparser == 1.1 12:53:09 INFO - mozInstall == 1.12 12:53:09 INFO - mozcrash == 0.16 12:53:09 INFO - mozdebug == 0.1 12:53:09 INFO - mozdevice == 0.48 12:53:09 INFO - mozfile == 1.2 12:53:09 INFO - mozhttpd == 0.7 12:53:09 INFO - mozinfo == 0.9 12:53:09 INFO - mozleak == 0.1 12:53:09 INFO - mozlog == 3.1 12:53:09 INFO - moznetwork == 0.27 12:53:09 INFO - mozprocess == 0.22 12:53:09 INFO - mozprofile == 0.28 12:53:09 INFO - mozrunner == 6.11 12:53:09 INFO - mozscreenshot == 0.1 12:53:09 INFO - mozsystemmonitor == 0.0 12:53:09 INFO - moztest == 0.7 12:53:09 INFO - mozversion == 1.4 12:53:09 INFO - psutil == 3.1.1 12:53:09 INFO - requests == 1.2.3 12:53:09 INFO - wsgiref == 0.1.2 12:53:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:53:09 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')]} 12:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:09 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')]} 12:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:09 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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:53:09 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 12:53:09 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 12:53:09 INFO - Using env: {'DISPLAY': ':0', 12:53:09 INFO - 'HOME': '/home/cltbld', 12:53:09 INFO - 'LANG': 'en_US.UTF-8', 12:53:09 INFO - 'LANGUAGE': 'en_US:en', 12:53:09 INFO - 'LOGNAME': 'cltbld', 12:53:09 INFO - 'MAIL': '/var/mail/cltbld', 12:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:09 INFO - 'MOZ_NO_REMOTE': '1', 12:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:09 INFO - 'NO_EM_RESTART': '1', 12:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:09 INFO - 'SHELL': '/bin/bash', 12:53:09 INFO - 'SHLVL': '1', 12:53:09 INFO - 'TERM': 'linux', 12:53:09 INFO - 'TMOUT': '86400', 12:53:09 INFO - 'USER': 'cltbld', 12:53:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:09 INFO - '_': '/tools/buildbot/bin/python'} 12:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 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)) 12:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:53:09 INFO - Cleaning up... 12:53:09 INFO - Return code: 0 12:53:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:53:09 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')]} 12:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:09 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')]} 12:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:09 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 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:53:09 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 12:53:09 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 12:53:09 INFO - Using env: {'DISPLAY': ':0', 12:53:09 INFO - 'HOME': '/home/cltbld', 12:53:09 INFO - 'LANG': 'en_US.UTF-8', 12:53:09 INFO - 'LANGUAGE': 'en_US:en', 12:53:09 INFO - 'LOGNAME': 'cltbld', 12:53:09 INFO - 'MAIL': '/var/mail/cltbld', 12:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:09 INFO - 'MOZ_NO_REMOTE': '1', 12:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:09 INFO - 'NO_EM_RESTART': '1', 12:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:09 INFO - 'SHELL': '/bin/bash', 12:53:09 INFO - 'SHLVL': '1', 12:53:09 INFO - 'TERM': 'linux', 12:53:09 INFO - 'TMOUT': '86400', 12:53:09 INFO - 'USER': 'cltbld', 12:53:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:09 INFO - '_': '/tools/buildbot/bin/python'} 12:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:09 INFO - Downloading/unpacking jsonschema 12:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:11 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 12:53:11 INFO - Downloading/unpacking functools32 (from jsonschema) 12:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:11 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:53:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:11 INFO - warning: no files found matching '*.txt' 12:53:11 INFO - no previously-included directories found matching 'build' 12:53:11 INFO - no previously-included directories found matching 'dist' 12:53:11 INFO - no previously-included directories found matching '.git*' 12:53:11 INFO - Installing collected packages: jsonschema, functools32 12:53:11 INFO - Running setup.py install for functools32 12:53:11 INFO - warning: no files found matching '*.txt' 12:53:11 INFO - no previously-included directories found matching 'build' 12:53:11 INFO - no previously-included directories found matching 'dist' 12:53:11 INFO - no previously-included directories found matching '.git*' 12:53:11 INFO - Successfully installed jsonschema functools32 12:53:11 INFO - Cleaning up... 12:53:11 INFO - Return code: 0 12:53:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58b2cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e35230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', '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 12:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:53:11 INFO - Using env: {'DISPLAY': ':0', 12:53:11 INFO - 'HOME': '/home/cltbld', 12:53:11 INFO - 'LANG': 'en_US.UTF-8', 12:53:11 INFO - 'LANGUAGE': 'en_US:en', 12:53:11 INFO - 'LOGNAME': 'cltbld', 12:53:11 INFO - 'MAIL': '/var/mail/cltbld', 12:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:11 INFO - 'MOZ_NO_REMOTE': '1', 12:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:11 INFO - 'NO_EM_RESTART': '1', 12:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:11 INFO - 'SHELL': '/bin/bash', 12:53:11 INFO - 'SHLVL': '1', 12:53:11 INFO - 'TERM': 'linux', 12:53:11 INFO - 'TMOUT': '86400', 12:53:11 INFO - 'USER': 'cltbld', 12:53:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:11 INFO - '_': '/tools/buildbot/bin/python'} 12:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:12 INFO - Downloading/unpacking flake8 12:53:12 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 12:53:12 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 12:53:12 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 12:53:12 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 12:53:12 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 12:53:12 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 12:53:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:53:13 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 12:53:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:53:14 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 12:53:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:14 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 12:53:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:53:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:53:14 INFO - no previously-included directories found matching 'docs/_build' 12:53:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:53:14 INFO - Running setup.py install for pep8 12:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:53:14 INFO - no previously-included directories found matching 'docs/_build' 12:53:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:53:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:53:14 INFO - Cleaning up... 12:53:14 INFO - Return code: 0 12:53:14 INFO - Running post-action listener: _resource_record_post_action 12:53:14 INFO - Running post-action listener: _start_resource_monitoring 12:53:14 INFO - Starting resource monitoring. 12:53:14 INFO - ##### 12:53:14 INFO - ##### Running install step. 12:53:14 INFO - ##### 12:53:14 INFO - Running pre-action listener: _resource_record_pre_action 12:53:14 INFO - Running main action method: install 12:53:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:53:15 INFO - Reading from file tmpfile_stdout 12:53:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:53:15 INFO - Reading from file tmpfile_stdout 12:53:15 INFO - Output received: 12:53:15 INFO - Usage: mozinstall [options] installer 12:53:15 INFO - Options: 12:53:15 INFO - -h, --help show this help message and exit 12:53:15 INFO - -d DEST, --destination=DEST 12:53:15 INFO - Directory to install application into. [default: 12:53:15 INFO - "/builds/slave/test-pgo"] 12:53:15 INFO - --app=APP Application being installed. [default: firefox] 12:53:15 INFO - mkdir: /builds/slave/test-pgo/build/application 12:53:15 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'] 12:53:15 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 12:53:31 INFO - Reading from file tmpfile_stdout 12:53:31 INFO - Output received: 12:53:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:53:31 INFO - Running post-action listener: _resource_record_post_action 12:53:31 INFO - ##### 12:53:31 INFO - ##### Running run-tests step. 12:53:31 INFO - ##### 12:53:31 INFO - Running pre-action listener: _resource_record_pre_action 12:53:31 INFO - Running main action method: run_tests 12:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:53:31 INFO - Python 2.7.3 12:53:31 INFO - Return code: 0 12:53:31 INFO - grabbing minidump binary from tooltool 12:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:31 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 0x1ec77f0>, '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 0x1e332d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e33760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:53:31 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 12:53:31 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 12:53:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:31 INFO - Return code: 0 12:53:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:53:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:53:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:53:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:53:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:53:32 INFO - Return code: 0 12:53:32 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/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:53:32 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/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 12:53:32 INFO - Using env: {'DISPLAY': ':0', 12:53:32 INFO - 'HOME': '/home/cltbld', 12:53:32 INFO - 'LANG': 'en_US.UTF-8', 12:53:32 INFO - 'LANGUAGE': 'en_US:en', 12:53:32 INFO - 'LOGNAME': 'cltbld', 12:53:32 INFO - 'MAIL': '/var/mail/cltbld', 12:53:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:32 INFO - 'MOZ_NO_REMOTE': '1', 12:53:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:32 INFO - 'NO_EM_RESTART': '1', 12:53:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:53:32 INFO - 'PWD': '/builds/slave/test-pgo', 12:53:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:53:32 INFO - 'SHELL': '/bin/bash', 12:53:32 INFO - 'SHLVL': '1', 12:53:32 INFO - 'TERM': 'linux', 12:53:32 INFO - 'TMOUT': '86400', 12:53:32 INFO - 'USER': 'cltbld', 12:53:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639', 12:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:32 INFO - '_': '/tools/buildbot/bin/python'} 12:53:32 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/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:53:32 INFO - mozversion application_buildid: 20160119103123 12:53:32 INFO - mozversion application_changeset: 94084e465160718075338e2e9e1ce6d04033237d 12:53:32 INFO - mozversion application_display_name: Nightly 12:53:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:32 INFO - mozversion application_name: Firefox 12:53:32 INFO - mozversion application_remotingname: firefox 12:53:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:53:32 INFO - mozversion application_vendor: Mozilla 12:53:32 INFO - mozversion application_version: 46.0a1 12:53:32 INFO - mozversion platform_buildid: 20160119103123 12:53:32 INFO - mozversion platform_changeset: 94084e465160718075338e2e9e1ce6d04033237d 12:53:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:53:32 INFO - mozversion platform_version: 46.0a1 12:53:32 INFO - using testdate: 1453236812 12:53:32 INFO - actual date: 1453236812 12:53:32 INFO - starting webserver on 'localhost:60293' 12:53:32 INFO - SUITE-START | Running 3 tests 12:53:32 INFO - TEST-START | dromaeo_css 12:53:32 INFO - operating with platform_type : linux_ 12:53:32 INFO - Initialising browser for dromaeo_css test... 12:53:32 INFO - TEST-INFO | started process 21533 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPWaLNh/profile http://localhost:60293/getInfo.html) 12:53:36 INFO - PROCESS | 21533 | 12:53:36 INFO - PROCESS | 21533 | (process:21619): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:53:37 INFO - PROCESS | 21533 | __metrics Screen width/height:1600/1200 12:53:37 INFO - PROCESS | 21533 | colorDepth:24 12:53:37 INFO - PROCESS | 21533 | Browser inner width/height: 1024/697 12:53:37 INFO - PROCESS | 21533 | __metrics 12:53:37 INFO - PROCESS | 21533 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:53:38 INFO - TEST-INFO | 21533: exit 0 12:53:38 INFO - Browser initialized. 12:53:38 INFO - Running cycle 1/1 for dromaeo_css test... 12:53:38 INFO - TEST-INFO | started process 21668 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPWaLNh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:39 INFO - PROCESS | 21668 | -- checkerboarding starts below -- 12:53:39 INFO - PROCESS | 21668 | RENDERTRACE 0.071334 rect red 0 0 10 10 // viewport 12:53:39 INFO - PROCESS | 21668 | RENDERTRACE 17.5704 rect brown 0 0 10 10 // page 12:53:39 INFO - PROCESS | 21668 | RENDERTRACE 17.5986 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 12:53:39 INFO - PROCESS | 21668 | Checkerboarded for 1 frames (33.3308 ms), 100 peak, 2 severity. 12:53:39 INFO - PROCESS | 21668 | 12:53:39 INFO - PROCESS | 21668 | (process:21726): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:53:50 INFO - PROCESS | 21668 | RSS: Main: 153571328 12:53:50 INFO - PROCESS | 21668 | 12:54:40 INFO - PROCESS | 21668 | 1453236880067 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] 12:56:49 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60293/tests/dromaeo/cssquery-ext.html) 12:56:50 INFO - PROCESS | 21668 | RSS: Main: 161628160 12:56:50 INFO - PROCESS | 21668 | 12:59:52 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-ext.html (next: http://localhost:60293/tests/dromaeo/cssquery-jquery.html) 12:59:53 INFO - PROCESS | 21668 | RSS: Main: 157765632 12:59:53 INFO - PROCESS | 21668 | 13:02:55 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60293/tests/dromaeo/cssquery-mootools.html) 13:02:55 INFO - PROCESS | 21668 | RSS: Main: 159363072 13:02:55 INFO - PROCESS | 21668 | 13:05:57 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60293/tests/dromaeo/cssquery-prototype.html) 13:05:57 INFO - PROCESS | 21668 | RSS: Main: 157028352 13:05:57 INFO - PROCESS | 21668 | 13:09:00 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60293/tests/dromaeo/cssquery-yui.html) 13:09:00 INFO - PROCESS | 21668 | RSS: Main: 157372416 13:09:00 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | Cycle 1(1): loaded http://localhost:60293/tests/dromaeo/cssquery-yui.html (next: http://localhost:60293/tests/dromaeo/cssquery-dojo.html) 13:12:03 INFO - PROCESS | 21668 | RSS: Main: 159498240 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | __start_tp_report 13:12:03 INFO - PROCESS | 21668 | _x_x_mozilla_page_load 13:12:03 INFO - PROCESS | 21668 | _x_x_mozilla_page_load_details 13:12:03 INFO - PROCESS | 21668 | |i|pagename|runs| 13:12:03 INFO - PROCESS | 21668 | |0;dojo.html;3230.047136094852;3239.5950506186728;3254.918627034325;3268.2809781847986;3293.9835300823506;5280.2079688046815;5288.8413347599635;5296.496832800883;5314.070037743394;5323.60072994526;5278.894422111555;5335.306410166682;5369.301990741208;5393.164059570763;5465.07093794055;4825.324454576362;4845.733484658343;4885.7312847793355;4914.434839993411;4956.281339205813;4878.585320247783;4930.087933732271;4978.402591689002;5000.249962505617;5019.849404517852;4749.382580264543;4844.903101937976;4849.563539281464;4863.756812159378;4907.533784290486;4844.636652251095;4846.151923413388;4856.17445034345;4881.731504767236;4883.462819089933;4840.564349208553;4849.539293767087;4852.611791056707;4867.172580661296;4873.853784386474;5063.8480845574695;5076.822311219126;5111.309973153614;5137.460566640486;5170;5690.573207009449;5721.199032135504;5725.427457254241;5725.599208055438;5727.513161381287;5674.063779476382;5729.713514324267;5750.827475175752;5753.993051216021;5763.5101016413655;5301.522862942354;5367.624266301399;5375.086235340002;5411.188321751769;5426.403095659474;5911.822645320647;5918.970405148033;5924;5930.495907847795;5933.376995415506;5473.75368108436;5550.972245138749;5656.264685590847;5683.431656834284;5699.401562835926;5751.511121554715;5773.855653608609;5787.768489260467;5804.65172089676;5869.501092407193;5722.656640601577;5725.370209277059;5763.567732420085;5775.075987842009;5778.451047150514;5482.451754824566;5582.302212223472;5596.776128954878;5754.223179870748;5787.508061814793;4437.2234858899565;4452.554744525586;4460.576245256695;4497.033137875373;4519.661025423106;3953.3081710700512;3991.820368083443;4001.8399264029113;4041.7372870763306;4053.8783836484954;5325.307709997675;5373.032854086302;5420.457954204548;5428.077226871442;5436.238926550286;5669.546436285087;5736.082226843685;5744.023516002206;5780.421957804186;5828.941710582924;5390.164524498709;5395.892082158413;5401.3248343957;5401.648892821954;5414;4753.120672675566;4824.614030877521;4872.049950259665;4942.357493525818;4977.626677999165;5963;5984.581079324493;5987.341392446828;6007.759689612367;6054.091886217015;5699.971500142473;5701.486866182064;5745.454181852718;5770.5095066919785;5782.363939966516;5842.620229685057;5844.912326315194;5976.491998180203;5998.550108741774;5999.70001499932;5687.976164290468;5713.657180569179;5719.142128680731;5737.225474560881;5793.188953546422;5789.102689083199;5794.304683438015;5797.391273916178;5814.04068328721;5847.532197424111;5568.276124103841;5569.944300556943;5638.097904335286;5658.490735833795;5698.401667824819;5640.097584386478;5644.9839028975175;5645.294338207724;5655.236543066798;5672.03575392176;5505.449455054462;5506.03644362243;5524.8342549723575;5526.834194974157;5538.030844602098;5520.392756796668;5620.662760234399;5628.577856660685;5652.0674088774895;5689.203511508309;5473.945260547343;5511.58663100261;5517.834464966058;5521.69630670317;5538.972305138448 13:12:03 INFO - PROCESS | 21668 | |1;ext.html;542.1380005790792;563.0596903171703;573.0979960237827;594.8007417515132;606.3421188011008;35577.82211088944;35686.10784730383;35895.82052089736;36153.2769344613;36275.637243627556;39500.60499395005;39589.40615890764;39622.40566391499;39980;39982.60017399825;8437.240648341649;8572.271356934669;8581.141885811432;8635.050144484101;8658.913410865905;8264.917350826505;8377.49735015898;8435.536045517494;8442.324614030893;8461.069282378934;8632.13678632138;8718.084601116887;8750.168733970262;8775.078616745246;8803.075677053914;8552.957235213846;8556.272716819078;8557.358198135134;8694.260987816075;8704.608292626846;8527.616257268437;8609;8633.266172375355;8657.913420865774;8675.522846243453;39565.60434395648;40065;40237;40245.39631905524;40354.59645403567;3227.6288226853976;3262.673732626742;3311.7516186286125;3758.5677647070665;4153.6050156739775;29230.85384573085;29600;29871.70128298711;29900.252493687833;30009.549856751946;3920.5491368492703;3936.2324346752393;4015.2371049500503;4112.9588704112875;4121.903742997665;256264;256432;256941.99999999814;257076.43156057835;257382;58351;58508.70745646244;58559;58623.70688146532;58762.70618646879;55802.72098639562;56684.71657641685;62499;62560;62571.374286257465;16340.346386144658;16716.498505044627;16731.330746770236;16805.747913781302;16833.326666933186;10639.840402393971;10795.190360722978;10818.513166907507;10826.891731082746;10859.511321990529;20452.079656415495;20615.175392984114;20625.174993000113;20663.4834129145;20674.793252067288;7712.344450721752;7812.335951444077;7847.489913155627;7910.644021019068;7917.3270272026375;937.4094320578129;1006.2704539209161;1051.7212938571286;1077.0199118801852;1101.823708206683;28927.7107228925;29040.41919161647;29180.27049323784;29345.413091738046;29368.26579335534;1030.407515678473;1080.8594882665361;1117.6479408986143;1135.2280449294394;1161.5005547614437;14908.329125189393;14935.701285974219;15101.848981510044;15164.924175379274;15282;322976;325315;326711;327805;329755;51781.48218517842;51846.22230666543;51936.220956685676;52369.47630523722;52524.474755251955;1307.7776777947772;1313.074282630743;1319.129374612751;1324.370923811182;1329.6476433745065;27395.726042739316;28452.430951380444;28540.714592853805;28596.142115736562;28973.130806075853;46955;47467.05065898732;47570.99999999862;47765.761171193924;47828.28257576209;305055;308127;308146;308549;309276;32324.67675323217;32919.67080329166;33005;33021.50467743034;33251.50122748112;43641.12717745691;43868;43932.341014884165;43988.34017489676;44930.20279188926;35903.820480897426;36738.8163059183;37028.259434810614;37347.81326093352;37398.439023415216;34262.657373425944;34718.305633887685;34979;35683.28633427369;36163.81918090498;34395.73318501462;34486.82756586201;34744.47883281804;34788;35014;29665.851670741507;32024;32162.356752864343;32213.194670132496;32440.35119297648;24371;24441.633375499026;24503.877480612482;24601.507969840146;24720 13:12:03 INFO - PROCESS | 21668 | |2;jquery.html;368.78610405964525;368.8045335971934;370.2853492758975;370.51647599882153;375.5343374215973;11318.717032074203;11706.7658646827;15726.921365393171;17447.65104697907;18436.985965771895;16984.15079246039;17119.40082097127;17244.051577163253;17273.82726172738;17305.91347043263;5535.225068490415;5793.304803423574;5808.390119037483;5815.82552523425;5821.970890145564;5612;6091.756329746805;6167.136600875881;6190.938090619104;6209.627422354673;6042.154098426224;6213.720382582795;6221.875562488747;6302.054691796245;6521.3478652134645;6291.1192433059405;6418.229812422493;6456.58032227906;6532.281449040602;6812.046313516112;6343.682815859234;6444.806655800334;6491.221053473566;6494.805155845333;6502.674866256668;19810.80189198104;20586.5882682347;20687.275945341993;20881.791182088138;20923.476913077142;2226.699395581592;2241.68616393705;2278.693324202678;2307.795920199955;2336.4158960259933;13776.448942042307;13784.586462406143;14017.85982140186;14329.713405731827;14411.567652970323;1961.7351657526194;1973.4572992427054;2006.9397918062482;2008.5480766827493;2065.979340206594;60118.699406503125;61524;62399.68800156016;62527.37472625261;63060.68469657622;15031.774523382159;15066.397344106113;15101.39594416211;15109.924450377677;15165.469208577646;23289.438161802187;23352.18267360634;23570.292891213292;23592.410189745395;23639.172628957906;7285.708571657075;7319.780406587811;7430.962845185848;7550.848983020309;8992.235659968976;6899.448044156456;6902.93097069033;7556.395488360918;7699.961500192463;7742.883856742041;4510.255807791743;4513.480949690827;4550.613197878151;4558.0655965526985;4583.931241031387;1882.905854707259;1942.805719428046;1943.9902800485906;3044.604201453841;3070.846457677107;903.4850135422878;907.1744712311764;965.980890160873;972.2270794718216;1019.8521214423866;16017.519474415787;16509.972717796267;16532.586685332964;16992.235349409308;17256.482305530855;917.7155081924625;958.8561715742694;993.0913214408735;1017.1049476460815;1033.4161198922584;9243.168114869693;9669.564869580885;9693.660721874841;9710.902890971;9845.655402061037;520504;531322;575398;577435;584573;72424.63787681027;74271;74949;76731;77446;1107.2581370481796;1125.3304283951036;1142.7600203957095;1151.4818331750746;1152.4180288954024;15465.381384744484;15529.611759706098;15726.68546629038;15815.367385304458;16087.115208663636;33768.83115584406;33813.323733525685;34149.82925085458;34350.14124646904;34750.30499389947;44335.55664443443;44513;45137.548624514646;45204.77397612991;46448.767756161;7011.579305241702;7148.499605027806;7557;7630.504017238862;7672.0409948756405;10065.496725163859;10669.57321707123;11597.420128993348;11733.471993760131;11758.353290568759;9840.470696354832;9849.426923365161;9861.309708320348;9863.901360986298;10036.146927511243;9474.857877131986;9621.90378096238;9783.804323913624;9912.900870991198;10115.696529104138;9888.208943284664;9949.204063674744;9978.60085596568;10137.847932281169;10407.323523970917;7362.77911662651;7559.3196612305155;7614;7821.1005734339005;7832.921670783448;8862.95568522179;9305.06949305091;9927.40435573868;9954.850677239992;10189.643362482277 13:12:03 INFO - PROCESS | 21668 | |3;mootools.html;1522.2693107308492;1537.2237020304744;1719.5099396671944;1834.357974708853;1880.1163453177003;7782.377409807209;7925.24710152536;7984.840303193932;8010.1589333120055;8123.959380203106;8015.559144247064;8046.275835174833;8096.352291816655;8114.594270286491;8119.26926576608;2347.2371479269264;2361.1027809432476;2378.108209421467;2378.120095564635;2379.4170428245106;2422.9757702422926;2439.2438344113293;2439.85360878347;2444.4377793107506;2453.7055553333535;2008.327210384523;2041.765197002349;2308.4344335637793;2375.524895020994;2392.174699728591;2264.2641141628874;2279.6922415473864;2283.794458498743;2287.8627282363027;2289.6679981402685;2253.6957510736006;2300.1719381022817;2300.976990230093;2304.055337311694;2305.008846196135;7947.483413578099;7974.481658692166;7981.720639777638;7994.24054714807;7998.960005199937;4828.348172996635;4981.178105612569;4991.825286114969;5002.874928126789;5020.824271150492;3141.6387115481557;3182.8726850925937;3189.3142974260413;3190.345979074284;3239.5950506186728;984.2322988069318;993.4833886379042;1006.1950439648325;1022.723864556573;1039.589362201926;11135.33188008714;11140.665780026531;11173.497192626352;11243.775124497464;11293.887061129366;4375.890602734957;4384.583464570861;4386.18855511725;4409.206342858252;4494.235979883428;9174.220191283815;9205.401648892801;9205.447673139633;9219.354645174773;9233.538323083952;4928.507149285115;4963.726995015237;4966.553010229097;4972;4994.600431965434;4499;4549.54504549549;4563.06457176278;4564;4567.995041090955;3594.2272411431145;3700.5929347771726;3711.3319602471274;3717.2937141942944;3738.5513738351574;1148.17905197784;1169.2283093158644;1172.8006238939402;1175.9176857620055;1177.664365655784;962.9903700963041;1003.3377970539409;1049.4437947887632;1058.899404556566;1100.1583788401879;7542.811429714301;7732.30409263169;7738.5356878586335;7759.107702614158;7763.611819409007;1056.197290059545;1091;1153.1927650644416;1161.715379731971;1190.089581470176;5903.881922361615;5929.495992840571;5973.910391344133;5988.610740301867;5991.872885125717;9171.770705732277;9678.661246856327;9722.805543889224;9739.951300243454;9953.203743700487;9866.851997220047;9915.107640312406;9916.900830991743;9973.501324933724;10024.19806415485;7409.110906691231;7570.394368450511;7619.352355049772;7640.197779233212;7672;7370.262973702587;7459.104907411145;7465.925340746523;7481.438892083224;7508.43686723487;8442.197991190827;8782.604782784661;8833.205011548991;8928.910710892807;8951.865722014305;8608.741737747878;8766.21104100634;8771.298296136421;8792.29661627081;8793.560321984003;7037.577745335297;7208.279172082959;7216.9639151806;7233;7261.891071634035;7612.733554325793;7629.618519073913;7643.808904777425;7689.115751688404;7763.767086987399;7406.0001899745;7506.3244308012545;7540.472166948261;7622.237776222333;7661.233876612294;7044.823879403056;7063.36429721307;7148.0350152728715;7185.461090418135;7355.485116041826;7155.105611798525;7156.105486814148;7187.604681742345;7202.96398518025;7252.492325537161;6385.10608514799;6398.392152745481;6461.19235095613;6478.287388387368;6488.12410324619;6582.506312026713;6647.734090636321;6657.700403481952;6666.766648170104;6696.5647232929705 13:12:03 INFO - PROCESS | 21668 | |4;prototype.html;316.51573093167445;333.23190046941795;335.7263829978569;342.3529529189832;343.7799808122802;6295.866743986081;6337.556371054028;6338;6348.714307856152;6412.230532336114;6198.81403557894;6228.657423841687;6267.498600111991;6293.748250069992;6301.40136687014;4775.164346239403;4789.6168306535565;4791.257355109963;4804.063207674505;4816.975915120437;4815.735134567597;4816.157172494817;4820.951790482103;4825.348577941985;4826.3001864729595;4667.06658668266;4731.1720448921305;4733.881652958687;4766.404199475066;4767.213409787381;4733.100710864925;4742.09900118978;4761.142994261032;4777.044591081798;4779.976100119477;4181.602747738991;4183.853565125237;4189.455370801807;4189.958100419018;4195.951012246938;6003.879922401527;6025.548083893682;6031.45716885478;6037.335893051761;6040.275166979946;5446.455354464561;5563.165525171256;5571.582131340166;5583.106702927553;5585.050541407971;6564.67176641166;6564.967175164142;6596.373344532261;6605.801825945181;6616.206055273398;4619.514950930137;4630.120277147331;4646.767661616906;4650.581447669692;4652.046330502273;6705.731770729214;6866.279040700754;6879.965600172017;6896.310368963113;6919.100516932817;4537.886552836139;4567.840125595588;4573.954260457353;4574.45106587205;4584.931226031612;4633.582977532038;4636.095961287517;4650.348951146842;4651.488336283006;4651.86044418668;5405.054115529767;5408.269883565747;5410.215518749759;5411.864703382447;5412.675239485643;6467.417932386108;6645.1361323027695;6648.4681225501845;6711.966440167866;6715.731370745116;1600.7674090949904;1626.146273206576;1627.7965254343208;1629.4867116858152;1652.4959887234268;1074.5486895503907;1075.870895492546;1087.211771465681;1088.9183311251688;1102.4102105373586;6129.448349648553;6167;6193.111101114113;6207.317195108534;6220.03589443637;6695.966520167368;6715.731370745213;6719.260881303053;6737.9663101685155;6745.966270168716;6083;6129.417705317987;6149.938500615026;6210.9068363974575;6257.499400047986;3634.5093412388987;3640.9453858192146;3660.3045421369857;3670.596234414212;3680.2087551176623;6999.195092564319;7004.754833580801;7055.012298278245;7064.399526040344;7081.929180708127;6680.665966701646;6884.793456196322;6898.206706228748;6915.204751453547;6933.965330173317;6791.660416979132;6845.5550389224545;6873.20958089816;6880.724771009103;6901.378875901193;6704.161979752531;6716.3955244028275;6730.73077076931;6733.2593414725325;6734.865302693821;6515.051093590894;6558.967205163944;6601.405873471411;6674.499412543982;6686;6988.231294557493;6991.091158149408;7019.719211231698;7030.578165309893;7047.929520704727;4532.32015197723;4605.424321959755;4607.331936869068;4613.746243956614;4619.376384188226;6769.052332673528;6770.898436523357;6781.593104413751;6781.694823732845;6924.688389022607;6669.699408615274;6670.533062685759;6677.432418244503;6677.833054173684;6709.060731497691;6672.199336079701;6692.063111164343;6693.129893114059;6716.630585317855;6737.3599508046655;6407.359264073555;6535.934640653532;6570.967145164243;6602.273749887605;6607.372299631527;6725.630090344882;6728.831779205559;6750.729970801113;6772.424343930821;6824.385805277549;6524.119243902012;6581.835454113494;6583.670816459062;6597.1423714916755;6599.855047109804 13:12:03 INFO - PROCESS | 21668 | |5;yui.html;765.9846803063939;832.0930186097155;833.3083540661252;838.1450920061537;858.2018722587991;13581.456741730331;13652.590422287323;13797.379117939692;13814.723705525896;14928.104313741183;14218.075825071362;14310.570682879505;14320.140791552514;14335.78496322556;14364.138151710904;794.2811755361407;809.8096947217399;809.9311558517533;810.9538695083365;811.8376324735048;828.1345993436843;830.3108420011406;831.3266254334009;831.3598529132564;834.7036801935317;842.9957850210741;846.86026805577;848.2789628815489;851.7657644147878;852.4160949749441;833.5373867503533;842.3682238321228;845.6279237135672;848.2916764501648;851.3146916732028;625.3652542669195;626.505061001808;626.5269721360389;629.2574761781096;631.9936800632026;14067.226302553356;14071;14150.36323365451;14151.71696566063;14196.290185490685;12231.571894983634;12430;12503.187292825936;12519.678762878439;12637.620871373874;10418.27072104953;10436.739081522946;10453.372797632166;10501.264911456201;10608.840867386996;3472.79791452343;3490.5985811631735;3502.807345595991;3511.613722490524;3591.5331006968927;47020;48554.27168592474;48643.5135648646;48986.51013489855;51884.2217366736;9504.714858554255;9858.014198580084;10163.44101074448;10187.7453063674;10350.792984140426;16602.58493537647;16768.83231167697;16777.161141942855;16793.91603041977;17086.060266685203;7349.118105827335;7413.925860741431;7428.257174282637;7525;7617.6572054256585;3871.922561548753;3917.275304068756;3958.7426817256787;3963.246983073207;4070.8575199867864;3018.109657650998;3038.8328641924904;3062.1732132324146;3066.9725641909763;3075.077476756964;585.7130006296884;600.8527910661916;600.8587981824268;602.9336772954971;610.9755609775559;605.3764622438895;638.2213699286863;641.9358064193543;655.1875674164097;693.1093544794915;7944.887715719804;8125.431219814556;8130.796730081795;8172.550509722022;8256.050554186346;518.9150500275899;555.4336770307693;595.330253464852;609.1563184988822;624.6782906803;3860.517435320585;3933.6066393361007;3936.933487800892;3969.622885825842;4014.6186112319283;51655;52133.7393313031;56592.151117733265;57287;57484.71257643768;48514;48524.7573762136;48655.75672121617;50125.74937125364;50821.74589127031;42902;44156;44243.778781106535;44326.113477730265;44386.11227775491;7879.724209652634;8026.197380261927;8153.429259951747;8754.69358572447;8875;32413.35173296568;32816.835915820266;32830.83584582062;33429.66570334265;33557.83221083977;40165.79917100396;41942.37086443767;42156.57843421526;43706.78146609246;44038.55961440473;10934.835977460503;11119.16606254518;11151.944240278746;11222.382768947786;11319.151063670093;11455.713607159887;11576.131790115607;12027.639170824888;12320.199187052813;12869.678258043623;10245.436500992517;10255.538500767334;10347.689569312932;10619.1504679627;10819.783604328028;10705.518251678848;10836.13310935139;10993.065589424989;11186.440677965906;11202.831957520806;9745.512724363613;10597.841032384675;10899.564017439214;11179.776404472028;11335.943320283346;9277.814443711222;9340.673076442292;9351.672691455766;9415;9786;8776.361277029915;9131.406458580172;9380.765480863032;9754.170895473964;9879.160271377013 13:12:03 INFO - PROCESS | 21668 | __end_tp_report 13:12:03 INFO - PROCESS | 21668 | __start_cc_report 13:12:03 INFO - PROCESS | 21668 | _x_x_mozilla_cycle_collect,317 13:12:03 INFO - PROCESS | 21668 | __end_cc_report 13:12:03 INFO - PROCESS | 21668 | __startTimestamp1453237923648__endTimestamp 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | ------- Summary: start ------- 13:12:03 INFO - PROCESS | 21668 | Number of tests: 6 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#0] dojo.html Cycles:165 Average:5334.93 Median:5520.39 stddev:585.90 (10.6%) stddev-sans-first:563.95 13:12:03 INFO - PROCESS | 21668 | Values: 3230.0 3239.6 3254.9 3268.3 3294.0 5280.2 5288.8 5296.5 5314.1 5323.6 5278.9 5335.3 5369.3 5393.2 5465.1 4825.3 4845.7 4885.7 4914.4 4956.3 4878.6 4930.1 4978.4 5000.2 5019.8 4749.4 4844.9 4849.6 4863.8 4907.5 4844.6 4846.2 4856.2 4881.7 4883.5 4840.6 4849.5 4852.6 4867.2 4873.9 5063.8 5076.8 5111.3 5137.5 5170.0 5690.6 5721.2 5725.4 5725.6 5727.5 5674.1 5729.7 5750.8 5754.0 5763.5 5301.5 5367.6 5375.1 5411.2 5426.4 5911.8 5919.0 5924.0 5930.5 5933.4 5473.8 5551.0 5656.3 5683.4 5699.4 5751.5 5773.9 5787.8 5804.7 5869.5 5722.7 5725.4 5763.6 5775.1 5778.5 5482.5 5582.3 5596.8 5754.2 5787.5 4437.2 4452.6 4460.6 4497.0 4519.7 3953.3 3991.8 4001.8 4041.7 4053.9 5325.3 5373.0 5420.5 5428.1 5436.2 5669.5 5736.1 5744.0 5780.4 5828.9 5390.2 5395.9 5401.3 5401.6 5414.0 4753.1 4824.6 4872.0 4942.4 4977.6 5963.0 5984.6 5987.3 6007.8 6054.1 5700.0 5701.5 5745.5 5770.5 5782.4 5842.6 5844.9 5976.5 5998.6 5999.7 5688.0 5713.7 5719.1 5737.2 5793.2 5789.1 5794.3 5797.4 5814.0 5847.5 5568.3 5569.9 5638.1 5658.5 5698.4 5640.1 5645.0 5645.3 5655.2 5672.0 5505.4 5506.0 5524.8 5526.8 5538.0 5520.4 5620.7 5628.6 5652.1 5689.2 5473.9 5511.6 5517.8 5521.7 5539.0 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#1] ext.html Cycles:180 Average:46607.34 Median:35630.55 stddev:78053.83 (219.1%) stddev-sans-first:78196.16 13:12:03 INFO - PROCESS | 21668 | Values: 542.1 563.1 573.1 594.8 606.3 35577.8 35686.1 35895.8 36153.3 36275.6 39500.6 39589.4 39622.4 39980.0 39982.6 8437.2 8572.3 8581.1 8635.1 8658.9 8264.9 8377.5 8435.5 8442.3 8461.1 8632.1 8718.1 8750.2 8775.1 8803.1 8553.0 8556.3 8557.4 8694.3 8704.6 8527.6 8609.0 8633.3 8657.9 8675.5 39565.6 40065.0 40237.0 40245.4 40354.6 3227.6 3262.7 3311.8 3758.6 4153.6 29230.9 29600.0 29871.7 29900.3 30009.5 3920.5 3936.2 4015.2 4113.0 4121.9 256264.0 256432.0 256942.0 257076.4 257382.0 58351.0 58508.7 58559.0 58623.7 58762.7 55802.7 56684.7 62499.0 62560.0 62571.4 16340.3 16716.5 16731.3 16805.7 16833.3 10639.8 10795.2 10818.5 10826.9 10859.5 20452.1 20615.2 20625.2 20663.5 20674.8 7712.3 7812.3 7847.5 7910.6 7917.3 937.4 1006.3 1051.7 1077.0 1101.8 28927.7 29040.4 29180.3 29345.4 29368.3 1030.4 1080.9 1117.6 1135.2 1161.5 14908.3 14935.7 15101.8 15164.9 15282.0 322976.0 325315.0 326711.0 327805.0 329755.0 51781.5 51846.2 51936.2 52369.5 52524.5 1307.8 1313.1 1319.1 1324.4 1329.6 27395.7 28452.4 28540.7 28596.1 28973.1 46955.0 47467.1 47571.0 47765.8 47828.3 305055.0 308127.0 308146.0 308549.0 309276.0 32324.7 32919.7 33005.0 33021.5 33251.5 43641.1 43868.0 43932.3 43988.3 44930.2 35903.8 36738.8 37028.3 37347.8 37398.4 34262.7 34718.3 34979.0 35683.3 36163.8 34395.7 34486.8 34744.5 34788.0 35014.0 29665.9 32024.0 32162.4 32213.2 32440.4 24371.0 24441.6 24503.9 24601.5 24720.0 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#2] jquery.html Cycles:180 Average:29109.38 Median:4571.00 stddev:91174.96 (1994.6%) stddev-sans-first:91405.19 13:12:03 INFO - PROCESS | 21668 | Values: 368.8 368.8 370.3 370.5 375.5 11318.7 11706.8 15726.9 17447.7 18437.0 16984.2 17119.4 17244.1 17273.8 17305.9 5535.2 5793.3 5808.4 5815.8 5822.0 5612.0 6091.8 6167.1 6190.9 6209.6 6042.2 6213.7 6221.9 6302.1 6521.3 6291.1 6418.2 6456.6 6532.3 6812.0 6343.7 6444.8 6491.2 6494.8 6502.7 19810.8 20586.6 20687.3 20881.8 20923.5 2226.7 2241.7 2278.7 2307.8 2336.4 13776.4 13784.6 14017.9 14329.7 14411.6 1961.7 1973.5 2006.9 2008.5 2066.0 60118.7 61524.0 62399.7 62527.4 63060.7 15031.8 15066.4 15101.4 15109.9 15165.5 23289.4 23352.2 23570.3 23592.4 23639.2 7285.7 7319.8 7431.0 7550.8 8992.2 6899.4 6902.9 7556.4 7700.0 7742.9 4510.3 4513.5 4550.6 4558.1 4583.9 1882.9 1942.8 1944.0 3044.6 3070.8 903.5 907.2 966.0 972.2 1019.9 16017.5 16510.0 16532.6 16992.2 17256.5 917.7 958.9 993.1 1017.1 1033.4 9243.2 9669.6 9693.7 9710.9 9845.7 520504.0 531322.0 575398.0 577435.0 584573.0 72424.6 74271.0 74949.0 76731.0 77446.0 1107.3 1125.3 1142.8 1151.5 1152.4 15465.4 15529.6 15726.7 15815.4 16087.1 33768.8 33813.3 34149.8 34350.1 34750.3 44335.6 44513.0 45137.5 45204.8 46448.8 7011.6 7148.5 7557.0 7630.5 7672.0 10065.5 10669.6 11597.4 11733.5 11758.4 9840.5 9849.4 9861.3 9863.9 10036.1 9474.9 9621.9 9783.8 9912.9 10115.7 9888.2 9949.2 9978.6 10137.8 10407.3 7362.8 7559.3 7614.0 7821.1 7832.9 8863.0 9305.1 9927.4 9954.9 10189.6 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#3] mootools.html Cycles:180 Average:5653.57 Median:6469.74 stddev:2941.83 (45.5%) stddev-sans-first:2933.70 13:12:03 INFO - PROCESS | 21668 | Values: 1522.3 1537.2 1719.5 1834.4 1880.1 7782.4 7925.2 7984.8 8010.2 8124.0 8015.6 8046.3 8096.4 8114.6 8119.3 2347.2 2361.1 2378.1 2378.1 2379.4 2423.0 2439.2 2439.9 2444.4 2453.7 2008.3 2041.8 2308.4 2375.5 2392.2 2264.3 2279.7 2283.8 2287.9 2289.7 2253.7 2300.2 2301.0 2304.1 2305.0 7947.5 7974.5 7981.7 7994.2 7999.0 4828.3 4981.2 4991.8 5002.9 5020.8 3141.6 3182.9 3189.3 3190.3 3239.6 984.2 993.5 1006.2 1022.7 1039.6 11135.3 11140.7 11173.5 11243.8 11293.9 4375.9 4384.6 4386.2 4409.2 4494.2 9174.2 9205.4 9205.4 9219.4 9233.5 4928.5 4963.7 4966.6 4972.0 4994.6 4499.0 4549.5 4563.1 4564.0 4568.0 3594.2 3700.6 3711.3 3717.3 3738.6 1148.2 1169.2 1172.8 1175.9 1177.7 963.0 1003.3 1049.4 1058.9 1100.2 7542.8 7732.3 7738.5 7759.1 7763.6 1056.2 1091.0 1153.2 1161.7 1190.1 5903.9 5929.5 5973.9 5988.6 5991.9 9171.8 9678.7 9722.8 9740.0 9953.2 9866.9 9915.1 9916.9 9973.5 10024.2 7409.1 7570.4 7619.4 7640.2 7672.0 7370.3 7459.1 7465.9 7481.4 7508.4 8442.2 8782.6 8833.2 8928.9 8951.9 8608.7 8766.2 8771.3 8792.3 8793.6 7037.6 7208.3 7217.0 7233.0 7261.9 7612.7 7629.6 7643.8 7689.1 7763.8 7406.0 7506.3 7540.5 7622.2 7661.2 7044.8 7063.4 7148.0 7185.5 7355.5 7155.1 7156.1 7187.6 7203.0 7252.5 6385.1 6398.4 6461.2 6478.3 6488.1 6582.5 6647.7 6657.7 6666.8 6696.6 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#4] prototype.html Cycles:180 Average:5510.39 Median:6243.08 stddev:1666.07 (26.7%) stddev-sans-first:1624.50 13:12:03 INFO - PROCESS | 21668 | Values: 316.5 333.2 335.7 342.4 343.8 6295.9 6337.6 6338.0 6348.7 6412.2 6198.8 6228.7 6267.5 6293.7 6301.4 4775.2 4789.6 4791.3 4804.1 4817.0 4815.7 4816.2 4821.0 4825.3 4826.3 4667.1 4731.2 4733.9 4766.4 4767.2 4733.1 4742.1 4761.1 4777.0 4780.0 4181.6 4183.9 4189.5 4190.0 4196.0 6003.9 6025.5 6031.5 6037.3 6040.3 5446.5 5563.2 5571.6 5583.1 5585.1 6564.7 6565.0 6596.4 6605.8 6616.2 4619.5 4630.1 4646.8 4650.6 4652.0 6705.7 6866.3 6880.0 6896.3 6919.1 4537.9 4567.8 4574.0 4574.5 4584.9 4633.6 4636.1 4650.3 4651.5 4651.9 5405.1 5408.3 5410.2 5411.9 5412.7 6467.4 6645.1 6648.5 6712.0 6715.7 1600.8 1626.1 1627.8 1629.5 1652.5 1074.5 1075.9 1087.2 1088.9 1102.4 6129.4 6167.0 6193.1 6207.3 6220.0 6696.0 6715.7 6719.3 6738.0 6746.0 6083.0 6129.4 6149.9 6210.9 6257.5 3634.5 3640.9 3660.3 3670.6 3680.2 6999.2 7004.8 7055.0 7064.4 7081.9 6680.7 6884.8 6898.2 6915.2 6934.0 6791.7 6845.6 6873.2 6880.7 6901.4 6704.2 6716.4 6730.7 6733.3 6734.9 6515.1 6559.0 6601.4 6674.5 6686.0 6988.2 6991.1 7019.7 7030.6 7047.9 4532.3 4605.4 4607.3 4613.7 4619.4 6769.1 6770.9 6781.6 6781.7 6924.7 6669.7 6670.5 6677.4 6677.8 6709.1 6672.2 6692.1 6693.1 6716.6 6737.4 6407.4 6535.9 6571.0 6602.3 6607.4 6725.6 6728.8 6750.7 6772.4 6824.4 6524.1 6581.8 6583.7 6597.1 6599.9 13:12:03 INFO - PROCESS | 21668 | 13:12:03 INFO - PROCESS | 21668 | [#5] yui.html Cycles:180 Average:13449.18 Median:44356.11 stddev:15389.62 (34.7%) stddev-sans-first:15403.32 13:12:03 INFO - PROCESS | 21668 | Values: 766.0 832.1 833.3 838.1 858.2 13581.5 13652.6 13797.4 13814.7 14928.1 14218.1 14310.6 14320.1 14335.8 14364.1 794.3 809.8 809.9 811.0 811.8 828.1 830.3 831.3 831.4 834.7 843.0 846.9 848.3 851.8 852.4 833.5 842.4 845.6 848.3 851.3 625.4 626.5 626.5 629.3 632.0 14067.2 14071.0 14150.4 14151.7 14196.3 12231.6 12430.0 12503.2 12519.7 12637.6 10418.3 10436.7 10453.4 10501.3 10608.8 3472.8 3490.6 3502.8 3511.6 3591.5 47020.0 48554.3 48643.5 48986.5 51884.2 9504.7 9858.0 10163.4 10187.7 10350.8 16602.6 16768.8 16777.2 16793.9 17086.1 7349.1 7413.9 7428.3 7525.0 7617.7 3871.9 3917.3 3958.7 3963.2 4070.9 3018.1 3038.8 3062.2 3067.0 3075.1 585.7 600.9 600.9 602.9 611.0 605.4 638.2 641.9 655.2 693.1 7944.9 8125.4 8130.8 8172.6 8256.1 518.9 555.4 595.3 609.2 624.7 3860.5 3933.6 3936.9 3969.6 4014.6 51655.0 52133.7 56592.2 57287.0 57484.7 48514.0 48524.8 48655.8 50125.7 50821.7 42902.0 44156.0 44243.8 44326.1 44386.1 7879.7 8026.2 8153.4 8754.7 8875.0 32413.4 32816.8 32830.8 33429.7 33557.8 40165.8 41942.4 42156.6 43706.8 44038.6 10934.8 11119.2 11151.9 11222.4 11319.2 11455.7 11576.1 12027.6 12320.2 12869.7 10245.4 10255.5 10347.7 10619.2 10819.8 10705.5 10836.1 10993.1 11186.4 11202.8 9745.5 10597.8 10899.6 11179.8 11335.9 9277.8 9340.7 9351.7 9415.0 9786.0 8776.4 9131.4 9380.8 9754.2 9879.2 13:12:03 INFO - PROCESS | 21668 | -------- Summary: end -------- 13:12:03 INFO - PROCESS | 21668 | 13:12:04 INFO - TEST-INFO | 21668: exit 0 13:12:04 INFO - TEST-OK | dromaeo_css | took 1112006ms 13:12:04 INFO - TEST-START | kraken 13:12:04 INFO - operating with platform_type : linux_ 13:12:04 INFO - Initialising browser for kraken test... 13:12:04 INFO - TEST-INFO | started process 21911 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM9_VZ/profile http://localhost:60293/getInfo.html) 13:12:08 INFO - PROCESS | 21911 | 13:12:08 INFO - PROCESS | 21911 | (process:21985): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:12:09 INFO - PROCESS | 21911 | __metrics Screen width/height:1600/1200 13:12:09 INFO - PROCESS | 21911 | colorDepth:24 13:12:09 INFO - PROCESS | 21911 | Browser inner width/height: 1024/697 13:12:09 INFO - PROCESS | 21911 | __metrics 13:12:09 INFO - PROCESS | 21911 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:12:10 INFO - TEST-INFO | 21911: exit 0 13:12:10 INFO - Browser initialized. 13:12:10 INFO - Running cycle 1/1 for kraken test... 13:12:10 INFO - TEST-INFO | started process 22034 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWM9_VZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:11 INFO - PROCESS | 22034 | -- checkerboarding starts below -- 13:12:11 INFO - PROCESS | 22034 | RENDERTRACE 0.038408 rect red 0 0 10 10 // viewport 13:12:11 INFO - PROCESS | 22034 | RENDERTRACE 1.26188 rect red 0 0 10 10 // viewport 13:12:11 INFO - PROCESS | 22034 | RENDERTRACE 16.0692 rect red 0 0 10 10 // viewport 13:12:11 INFO - PROCESS | 22034 | RENDERTRACE 26.3769 rect brown 0 0 10 10 // page 13:12:11 INFO - PROCESS | 22034 | RENDERTRACE 26.392 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:12:11 INFO - PROCESS | 22034 | Checkerboarded for 3 frames (33.1047 ms), 100 peak, 1605 severity. 13:12:11 INFO - PROCESS | 22034 | 13:12:11 INFO - PROCESS | 22034 | (process:22091): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:12:22 INFO - PROCESS | 22034 | RSS: Main: 152981504 13:12:22 INFO - PROCESS | 22034 | 13:12:24 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60293/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:25 INFO - PROCESS | 22034 | RSS: Main: 157577216 13:12:25 INFO - PROCESS | 22034 | 13:12:27 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60293/tests/kraken/driver.html?testName=audio-dft) 13:12:28 INFO - PROCESS | 22034 | RSS: Main: 160968704 13:12:28 INFO - PROCESS | 22034 | 13:12:31 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60293/tests/kraken/driver.html?testName=audio-fft) 13:12:31 INFO - PROCESS | 22034 | RSS: Main: 155754496 13:12:31 INFO - PROCESS | 22034 | 13:12:34 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60293/tests/kraken/driver.html?testName=audio-oscillator) 13:12:34 INFO - PROCESS | 22034 | RSS: Main: 156536832 13:12:34 INFO - PROCESS | 22034 | 13:12:37 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:37 INFO - PROCESS | 22034 | RSS: Main: 157052928 13:12:37 INFO - PROCESS | 22034 | 13:12:40 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60293/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:41 INFO - PROCESS | 22034 | RSS: Main: 155602944 13:12:41 INFO - PROCESS | 22034 | 13:12:44 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60293/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:45 INFO - PROCESS | 22034 | RSS: Main: 157589504 13:12:45 INFO - PROCESS | 22034 | 13:12:48 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60293/tests/kraken/driver.html?testName=json-parse-financial) 13:12:48 INFO - PROCESS | 22034 | RSS: Main: 156884992 13:12:48 INFO - PROCESS | 22034 | 13:12:50 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:50 INFO - PROCESS | 22034 | RSS: Main: 157032448 13:12:50 INFO - PROCESS | 22034 | 13:12:52 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:53 INFO - PROCESS | 22034 | RSS: Main: 155615232 13:12:53 INFO - PROCESS | 22034 | 13:12:55 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:55 INFO - PROCESS | 22034 | RSS: Main: 156160000 13:12:55 INFO - PROCESS | 22034 | 13:12:58 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:58 INFO - PROCESS | 22034 | RSS: Main: 156581888 13:12:58 INFO - PROCESS | 22034 | 13:13:01 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:02 INFO - PROCESS | 22034 | RSS: Main: 157896704 13:13:02 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | Cycle 1(1): loaded http://localhost:60293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60293/tests/kraken/driver.html?testName=ai-astar) 13:13:03 INFO - PROCESS | 22034 | RSS: Main: 157605888 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | __start_tp_report 13:13:03 INFO - PROCESS | 22034 | _x_x_mozilla_page_load 13:13:03 INFO - PROCESS | 22034 | _x_x_mozilla_page_load_details 13:13:03 INFO - PROCESS | 22034 | |i|pagename|runs| 13:13:03 INFO - PROCESS | 22034 | |0;ai-astar;112;108;111;111;113;123;111;110;111;112 13:13:03 INFO - PROCESS | 22034 | |1;audio-beat-detection;155;126;154;166;130;150;149;138;169;130 13:13:03 INFO - PROCESS | 22034 | |2;audio-dft;162;163;163;165;164;164;164;172;163;161 13:13:03 INFO - PROCESS | 22034 | |3;audio-fft;74;73;74;74;74;73;144;74;73;76 13:13:03 INFO - PROCESS | 22034 | |4;audio-oscillator;101;99;160;96;97;97;144;97;97;145 13:13:03 INFO - PROCESS | 22034 | |5;imaging-gaussian-blur;110;110;110;110;109;111;114;110;110;110 13:13:03 INFO - PROCESS | 22034 | |6;imaging-darkroom;147;146;149;148;146;146;148;146;147;147 13:13:03 INFO - PROCESS | 22034 | |7;imaging-desaturate;97;97;97;97;98;96;96;96;97;96 13:13:03 INFO - PROCESS | 22034 | |8;json-parse-financial;60;60;60;60;61;59;60;63;69;59 13:13:03 INFO - PROCESS | 22034 | |9;json-stringify-tinderbox;67;67;68;68;69;68;68;68;72;68 13:13:03 INFO - PROCESS | 22034 | |10;stanford-crypto-aes;83;83;87;84;85;85;92;84;84;82 13:13:03 INFO - PROCESS | 22034 | |11;stanford-crypto-ccm;119;118;122;113;120;119;116;122;121;114 13:13:03 INFO - PROCESS | 22034 | |12;stanford-crypto-pbkdf2;131;145;141;139;141;130;156;144;152;128 13:13:03 INFO - PROCESS | 22034 | |13;stanford-crypto-sha256-iterative;67;67;66;68;68;66;70;66;65;65 13:13:03 INFO - PROCESS | 22034 | __end_tp_report 13:13:03 INFO - PROCESS | 22034 | __start_cc_report 13:13:03 INFO - PROCESS | 22034 | _x_x_mozilla_cycle_collect,746 13:13:03 INFO - PROCESS | 22034 | __end_cc_report 13:13:03 INFO - PROCESS | 22034 | __startTimestamp1453237983977__endTimestamp 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | ------- Summary: start ------- 13:13:03 INFO - PROCESS | 22034 | Number of tests: 14 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.50 stddev:4.02 (3.6%) stddev-sans-first:4.27 13:13:03 INFO - PROCESS | 22034 | Values: 112.0 108.0 111.0 111.0 113.0 123.0 111.0 110.0 111.0 112.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:152.00 stddev:15.17 (10.0%) stddev-sans-first:15.79 13:13:03 INFO - PROCESS | 22034 | Values: 155.0 126.0 154.0 166.0 130.0 150.0 149.0 138.0 169.0 130.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.00 (1.8%) stddev-sans-first:3.08 13:13:03 INFO - PROCESS | 22034 | Values: 162.0 163.0 163.0 165.0 164.0 164.0 164.0 172.0 163.0 161.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#3] audio-fft Cycles:10 Average:80.90 Median:74.00 stddev:22.19 (30.0%) stddev-sans-first:23.39 13:13:03 INFO - PROCESS | 22034 | Values: 74.0 73.0 74.0 74.0 74.0 73.0 144.0 74.0 73.0 76.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#4] audio-oscillator Cycles:10 Average:113.30 Median:97.00 stddev:25.49 (26.3%) stddev-sans-first:26.64 13:13:03 INFO - PROCESS | 22034 | Values: 101.0 99.0 160.0 96.0 97.0 97.0 144.0 97.0 97.0 145.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 13:13:03 INFO - PROCESS | 22034 | Values: 110.0 110.0 110.0 110.0 109.0 111.0 114.0 110.0 110.0 110.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 13:13:03 INFO - PROCESS | 22034 | Values: 147.0 146.0 149.0 148.0 146.0 146.0 148.0 146.0 147.0 147.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:13:03 INFO - PROCESS | 22034 | Values: 97.0 97.0 97.0 97.0 98.0 96.0 96.0 96.0 97.0 96.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.00 stddev:3.00 (5.0%) stddev-sans-first:3.15 13:13:03 INFO - PROCESS | 22034 | Values: 60.0 60.0 60.0 60.0 61.0 59.0 60.0 63.0 69.0 59.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.42 13:13:03 INFO - PROCESS | 22034 | Values: 67.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 72.0 68.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.85 (3.4%) stddev-sans-first:2.93 13:13:03 INFO - PROCESS | 22034 | Values: 83.0 83.0 87.0 84.0 85.0 85.0 92.0 84.0 84.0 82.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.50 stddev:3.17 (2.7%) stddev-sans-first:3.35 13:13:03 INFO - PROCESS | 22034 | Values: 119.0 118.0 122.0 113.0 120.0 119.0 116.0 122.0 121.0 114.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:142.50 stddev:9.21 (6.5%) stddev-sans-first:9.08 13:13:03 INFO - PROCESS | 22034 | Values: 131.0 145.0 141.0 139.0 141.0 130.0 156.0 144.0 152.0 128.0 13:13:03 INFO - PROCESS | 22034 | 13:13:03 INFO - PROCESS | 22034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 13:13:03 INFO - PROCESS | 22034 | Values: 67.0 67.0 66.0 68.0 68.0 66.0 70.0 66.0 65.0 65.0 13:13:03 INFO - PROCESS | 22034 | -------- Summary: end -------- 13:13:03 INFO - PROCESS | 22034 | 13:13:04 INFO - TEST-INFO | 22034: exit 0 13:13:04 INFO - TEST-OK | kraken | took 60574ms 13:13:04 INFO - TEST-START | v8_7 13:13:04 INFO - operating with platform_type : linux_ 13:13:04 INFO - Initialising browser for v8_7 test... 13:13:04 INFO - TEST-INFO | started process 22319 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD36cs6/profile http://localhost:60293/getInfo.html) 13:13:08 INFO - PROCESS | 22319 | 13:13:08 INFO - PROCESS | 22319 | (process:22393): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:13:09 INFO - PROCESS | 22319 | __metrics Screen width/height:1600/1200 13:13:09 INFO - PROCESS | 22319 | colorDepth:24 13:13:09 INFO - PROCESS | 22319 | Browser inner width/height: 1024/697 13:13:09 INFO - PROCESS | 22319 | __metrics 13:13:09 INFO - PROCESS | 22319 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:13:10 INFO - TEST-INFO | 22319: exit 0 13:13:10 INFO - Browser initialized. 13:13:10 INFO - Running cycle 1/1 for v8_7 test... 13:13:10 INFO - TEST-INFO | started process 22442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD36cs6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:11 INFO - PROCESS | 22442 | -- checkerboarding starts below -- 13:13:11 INFO - PROCESS | 22442 | RENDERTRACE 0.060618 rect red 0 0 10 10 // viewport 13:13:11 INFO - PROCESS | 22442 | RENDERTRACE 19.1018 rect brown 0 0 10 10 // page 13:13:11 INFO - PROCESS | 22442 | RENDERTRACE 19.1416 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 13:13:11 INFO - PROCESS | 22442 | Checkerboarded for 1 frames (20.1476 ms), 100 peak, 2 severity. 13:13:12 INFO - PROCESS | 22442 | 13:13:12 INFO - PROCESS | 22442 | (process:22500): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:13:22 INFO - PROCESS | 22442 | RSS: Main: 153165824 13:13:22 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | Cycle 1(1): loaded http://localhost:60293/tests/v8_7/run.html (next: http://localhost:60293/tests/v8_7/run.html) 13:13:45 INFO - PROCESS | 22442 | RSS: Main: 153427968 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | __start_tp_report 13:13:45 INFO - PROCESS | 22442 | _x_x_mozilla_page_load 13:13:45 INFO - PROCESS | 22442 | _x_x_mozilla_page_load_details 13:13:45 INFO - PROCESS | 22442 | |i|pagename|runs| 13:13:45 INFO - PROCESS | 22442 | |0;Richards;167.42005692281936 13:13:45 INFO - PROCESS | 22442 | |1;DeltaBlue;194.32568985619898 13:13:45 INFO - PROCESS | 22442 | |2;Encrypt;282.7254735651682 13:13:45 INFO - PROCESS | 22442 | |3;Decrypt;5268.421052631579 13:13:45 INFO - PROCESS | 22442 | |4;RayTrace;1072.961373390558 13:13:45 INFO - PROCESS | 22442 | |5;Earley;718.3908045977012 13:13:45 INFO - PROCESS | 22442 | |6;Boyer;12612.5 13:13:45 INFO - PROCESS | 22442 | |7;RegExp;41060 13:13:45 INFO - PROCESS | 22442 | |8;Splay;590.9090909090909 13:13:45 INFO - PROCESS | 22442 | |9;NavierStokes;4826.923076923077 13:13:45 INFO - PROCESS | 22442 | __end_tp_report 13:13:45 INFO - PROCESS | 22442 | __startTimestamp1453238025310__endTimestamp 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | ------- Summary: start ------- 13:13:45 INFO - PROCESS | 22442 | Number of tests: 10 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 167.4 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#1] DeltaBlue Cycles:1 Average:194.33 Median:194.33 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 194.3 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 282.7 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 5268.4 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 1073.0 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 718.4 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#6] Boyer Cycles:1 Average:12612.50 Median:12612.50 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 12612.5 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#7] RegExp Cycles:1 Average:41060.00 Median:41060.00 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 41060.0 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#8] Splay Cycles:1 Average:590.91 Median:590.91 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 590.9 13:13:45 INFO - PROCESS | 22442 | 13:13:45 INFO - PROCESS | 22442 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 13:13:45 INFO - PROCESS | 22442 | Values: 4826.9 13:13:45 INFO - PROCESS | 22442 | -------- Summary: end -------- 13:13:45 INFO - PROCESS | 22442 | 13:13:46 INFO - TEST-INFO | 22442: exit 0 13:13:46 INFO - TEST-OK | v8_7 | took 41302ms 13:13:46 INFO - SUITE-END | took 1213s 13:13:46 INFO - Completed test suite (00:20:13) 13:13:46 INFO - Working with test: dromaeo_css 13:13:46 INFO - Generating results file: dromaeo_css 13:13:46 INFO - Working with test: kraken 13:13:46 INFO - Generating results file: kraken 13:13:46 INFO - javascript benchmark 13:13:46 INFO - Working with test: v8_7 13:13:46 INFO - Generating results file: v8_7 13:13:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 13:13:46 INFO - process_Request line: dromaeo_css 7064.94 graph.html#tests=[[72,63,43]] 13:13:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:46 INFO - process_Request line: kraken 1511.50 graph.html#tests=[[232,63,43]] 13:13:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:13:46 INFO - process_Request line: v8_7 20227.32 graph.html#tests=[[230,63,43]] 13:13:46 INFO - RETURN: dromaeo_css: 7064.94 13:13:46 INFO - RETURN: kraken: 1511.50 13:13:46 INFO - RETURN: v8_7: 20227.32 13:13:46 INFO - javascript benchmark 13:13:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3230.047136094852, 3239.5950506186728, 3254.918627034325, 3268.2809781847986, 3293.9835300823506, 5280.2079688046815, 5288.8413347599635, 5296.496832800883, 5314.070037743394, 5323.60072994526, 5278.894422111555, 5335.306410166682, 5369.301990741208, 5393.164059570763, 5465.07093794055, 4825.324454576362, 4845.733484658343, 4885.7312847793355, 4914.434839993411, 4956.281339205813, 4878.585320247783, 4930.087933732271, 4978.402591689002, 5000.249962505617, 5019.849404517852, 4749.382580264543, 4844.903101937976, 4849.563539281464, 4863.756812159378, 4907.533784290486, 4844.636652251095, 4846.151923413388, 4856.17445034345, 4881.731504767236, 4883.462819089933, 4840.564349208553, 4849.539293767087, 4852.611791056707, 4867.172580661296, 4873.853784386474, 5063.8480845574695, 5076.822311219126, 5111.309973153614, 5137.460566640486, 5170.0, 5690.573207009449, 5721.199032135504, 5725.427457254241, 5725.599208055438, 5727.513161381287, 5674.063779476382, 5729.713514324267, 5750.827475175752, 5753.993051216021, 5763.5101016413655, 5301.522862942354, 5367.624266301399, 5375.086235340002, 5411.188321751769, 5426.403095659474, 5911.822645320647, 5918.970405148033, 5924.0, 5930.495907847795, 5933.376995415506, 5473.75368108436, 5550.972245138749, 5656.264685590847, 5683.431656834284, 5699.401562835926, 5751.511121554715, 5773.855653608609, 5787.768489260467, 5804.65172089676, 5869.501092407193, 5722.656640601577, 5725.370209277059, 5763.567732420085, 5775.075987842009, 5778.451047150514, 5482.451754824566, 5582.302212223472, 5596.776128954878, 5754.223179870748, 5787.508061814793, 4437.2234858899565, 4452.554744525586, 4460.576245256695, 4497.033137875373, 4519.661025423106, 3953.3081710700512, 3991.820368083443, 4001.8399264029113, 4041.7372870763306, 4053.8783836484954, 5325.307709997675, 5373.032854086302, 5420.457954204548, 5428.077226871442, 5436.238926550286, 5669.546436285087, 5736.082226843685, 5744.023516002206, 5780.421957804186, 5828.941710582924, 5390.164524498709, 5395.892082158413, 5401.3248343957, 5401.648892821954, 5414.0, 4753.120672675566, 4824.614030877521, 4872.049950259665, 4942.357493525818, 4977.626677999165, 5963.0, 5984.581079324493, 5987.341392446828, 6007.759689612367, 6054.091886217015, 5699.971500142473, 5701.486866182064, 5745.454181852718, 5770.5095066919785, 5782.363939966516, 5842.620229685057, 5844.912326315194, 5976.491998180203, 5998.550108741774, 5999.70001499932, 5687.976164290468, 5713.657180569179, 5719.142128680731, 5737.225474560881, 5793.188953546422, 5789.102689083199, 5794.304683438015, 5797.391273916178, 5814.04068328721, 5847.532197424111, 5568.276124103841, 5569.944300556943, 5638.097904335286, 5658.490735833795, 5698.401667824819, 5640.097584386478, 5644.9839028975175, 5645.294338207724, 5655.236543066798, 5672.03575392176, 5505.449455054462, 5506.03644362243, 5524.8342549723575, 5526.834194974157, 5538.030844602098, 5520.392756796668, 5620.662760234399, 5628.577856660685, 5652.0674088774895, 5689.203511508309, 5473.945260547343, 5511.58663100261, 5517.834464966058, 5521.69630670317, 5538.972305138448], "unit": "score", "name": "dojo.html", "value": 5297.721208279759}, {"lowerIsBetter": false, "replicates": [542.1380005790792, 563.0596903171703, 573.0979960237827, 594.8007417515132, 606.3421188011008, 35577.82211088944, 35686.10784730383, 35895.82052089736, 36153.2769344613, 36275.637243627556, 39500.60499395005, 39589.40615890764, 39622.40566391499, 39980.0, 39982.60017399825, 8437.240648341649, 8572.271356934669, 8581.141885811432, 8635.050144484101, 8658.913410865905, 8264.917350826505, 8377.49735015898, 8435.536045517494, 8442.324614030893, 8461.069282378934, 8632.13678632138, 8718.084601116887, 8750.168733970262, 8775.078616745246, 8803.075677053914, 8552.957235213846, 8556.272716819078, 8557.358198135134, 8694.260987816075, 8704.608292626846, 8527.616257268437, 8609.0, 8633.266172375355, 8657.913420865774, 8675.522846243453, 39565.60434395648, 40065.0, 40237.0, 40245.39631905524, 40354.59645403567, 3227.6288226853976, 3262.673732626742, 3311.7516186286125, 3758.5677647070665, 4153.6050156739775, 29230.85384573085, 29600.0, 29871.70128298711, 29900.252493687833, 30009.549856751946, 3920.5491368492703, 3936.2324346752393, 4015.2371049500503, 4112.9588704112875, 4121.903742997665, 256264.0, 256432.0, 256941.99999999814, 257076.43156057835, 257382.0, 58351.0, 58508.70745646244, 58559.0, 58623.70688146532, 58762.70618646879, 55802.72098639562, 56684.71657641685, 62499.0, 62560.0, 62571.374286257465, 16340.346386144658, 16716.498505044627, 16731.330746770236, 16805.747913781302, 16833.326666933186, 10639.840402393971, 10795.190360722978, 10818.513166907507, 10826.891731082746, 10859.511321990529, 20452.079656415495, 20615.175392984114, 20625.174993000113, 20663.4834129145, 20674.793252067288, 7712.344450721752, 7812.335951444077, 7847.489913155627, 7910.644021019068, 7917.3270272026375, 937.4094320578129, 1006.2704539209161, 1051.7212938571286, 1077.0199118801852, 1101.823708206683, 28927.7107228925, 29040.41919161647, 29180.27049323784, 29345.413091738046, 29368.26579335534, 1030.407515678473, 1080.8594882665361, 1117.6479408986143, 1135.2280449294394, 1161.5005547614437, 14908.329125189393, 14935.701285974219, 15101.848981510044, 15164.924175379274, 15282.0, 322976.0, 325315.0, 326711.0, 327805.0, 329755.0, 51781.48218517842, 51846.22230666543, 51936.220956685676, 52369.47630523722, 52524.474755251955, 1307.7776777947772, 1313.074282630743, 1319.129374612751, 1324.370923811182, 1329.6476433745065, 27395.726042739316, 28452.430951380444, 28540.714592853805, 28596.142115736562, 28973.130806075853, 46955.0, 47467.05065898732, 47570.99999999862, 47765.761171193924, 47828.28257576209, 305055.0, 308127.0, 308146.0, 308549.0, 309276.0, 32324.67675323217, 32919.67080329166, 33005.0, 33021.50467743034, 33251.50122748112, 43641.12717745691, 43868.0, 43932.341014884165, 43988.34017489676, 44930.20279188926, 35903.820480897426, 36738.8163059183, 37028.259434810614, 37347.81326093352, 37398.439023415216, 34262.657373425944, 34718.305633887685, 34979.0, 35683.28633427369, 36163.81918090498, 34395.73318501462, 34486.82756586201, 34744.47883281804, 34788.0, 35014.0, 29665.851670741507, 32024.0, 32162.356752864343, 32213.194670132496, 32440.35119297648, 24371.0, 24441.633375499026, 24503.877480612482, 24601.507969840146, 24720.0], "unit": "score", "name": "ext.html", "value": 18491.744422296448}, {"lowerIsBetter": false, "replicates": [368.78610405964525, 368.8045335971934, 370.2853492758975, 370.51647599882153, 375.5343374215973, 11318.717032074203, 11706.7658646827, 15726.921365393171, 17447.65104697907, 18436.985965771895, 16984.15079246039, 17119.40082097127, 17244.051577163253, 17273.82726172738, 17305.91347043263, 5535.225068490415, 5793.304803423574, 5808.390119037483, 5815.82552523425, 5821.970890145564, 5612.0, 6091.756329746805, 6167.136600875881, 6190.938090619104, 6209.627422354673, 6042.154098426224, 6213.720382582795, 6221.875562488747, 6302.054691796245, 6521.3478652134645, 6291.1192433059405, 6418.229812422493, 6456.58032227906, 6532.281449040602, 6812.046313516112, 6343.682815859234, 6444.806655800334, 6491.221053473566, 6494.805155845333, 6502.674866256668, 19810.80189198104, 20586.5882682347, 20687.275945341993, 20881.791182088138, 20923.476913077142, 2226.699395581592, 2241.68616393705, 2278.693324202678, 2307.795920199955, 2336.4158960259933, 13776.448942042307, 13784.586462406143, 14017.85982140186, 14329.713405731827, 14411.567652970323, 1961.7351657526194, 1973.4572992427054, 2006.9397918062482, 2008.5480766827493, 2065.979340206594, 60118.699406503125, 61524.0, 62399.68800156016, 62527.37472625261, 63060.68469657622, 15031.774523382159, 15066.397344106113, 15101.39594416211, 15109.924450377677, 15165.469208577646, 23289.438161802187, 23352.18267360634, 23570.292891213292, 23592.410189745395, 23639.172628957906, 7285.708571657075, 7319.780406587811, 7430.962845185848, 7550.848983020309, 8992.235659968976, 6899.448044156456, 6902.93097069033, 7556.395488360918, 7699.961500192463, 7742.883856742041, 4510.255807791743, 4513.480949690827, 4550.613197878151, 4558.0655965526985, 4583.931241031387, 1882.905854707259, 1942.805719428046, 1943.9902800485906, 3044.604201453841, 3070.846457677107, 903.4850135422878, 907.1744712311764, 965.980890160873, 972.2270794718216, 1019.8521214423866, 16017.519474415787, 16509.972717796267, 16532.586685332964, 16992.235349409308, 17256.482305530855, 917.7155081924625, 958.8561715742694, 993.0913214408735, 1017.1049476460815, 1033.4161198922584, 9243.168114869693, 9669.564869580885, 9693.660721874841, 9710.902890971, 9845.655402061037, 520504.0, 531322.0, 575398.0, 577435.0, 584573.0, 72424.63787681027, 74271.0, 74949.0, 76731.0, 77446.0, 1107.2581370481796, 1125.3304283951036, 1142.7600203957095, 1151.4818331750746, 1152.4180288954024, 15465.381384744484, 15529.611759706098, 15726.68546629038, 15815.367385304458, 16087.115208663636, 33768.83115584406, 33813.323733525685, 34149.82925085458, 34350.14124646904, 34750.30499389947, 44335.55664443443, 44513.0, 45137.548624514646, 45204.77397612991, 46448.767756161, 7011.579305241702, 7148.499605027806, 7557.0, 7630.504017238862, 7672.0409948756405, 10065.496725163859, 10669.57321707123, 11597.420128993348, 11733.471993760131, 11758.353290568759, 9840.470696354832, 9849.426923365161, 9861.309708320348, 9863.901360986298, 10036.146927511243, 9474.857877131986, 9621.90378096238, 9783.804323913624, 9912.900870991198, 10115.696529104138, 9888.208943284664, 9949.204063674744, 9978.60085596568, 10137.847932281169, 10407.323523970917, 7362.77911662651, 7559.3196612305155, 7614.0, 7821.1005734339005, 7832.921670783448, 8862.95568522179, 9305.06949305091, 9927.40435573868, 9954.850677239992, 10189.643362482277], "unit": "score", "name": "jquery.html", "value": 8916.157579977233}, {"lowerIsBetter": false, "replicates": [1522.2693107308492, 1537.2237020304744, 1719.5099396671944, 1834.357974708853, 1880.1163453177003, 7782.377409807209, 7925.24710152536, 7984.840303193932, 8010.1589333120055, 8123.959380203106, 8015.559144247064, 8046.275835174833, 8096.352291816655, 8114.594270286491, 8119.26926576608, 2347.2371479269264, 2361.1027809432476, 2378.108209421467, 2378.120095564635, 2379.4170428245106, 2422.9757702422926, 2439.2438344113293, 2439.85360878347, 2444.4377793107506, 2453.7055553333535, 2008.327210384523, 2041.765197002349, 2308.4344335637793, 2375.524895020994, 2392.174699728591, 2264.2641141628874, 2279.6922415473864, 2283.794458498743, 2287.8627282363027, 2289.6679981402685, 2253.6957510736006, 2300.1719381022817, 2300.976990230093, 2304.055337311694, 2305.008846196135, 7947.483413578099, 7974.481658692166, 7981.720639777638, 7994.24054714807, 7998.960005199937, 4828.348172996635, 4981.178105612569, 4991.825286114969, 5002.874928126789, 5020.824271150492, 3141.6387115481557, 3182.8726850925937, 3189.3142974260413, 3190.345979074284, 3239.5950506186728, 984.2322988069318, 993.4833886379042, 1006.1950439648325, 1022.723864556573, 1039.589362201926, 11135.33188008714, 11140.665780026531, 11173.497192626352, 11243.775124497464, 11293.887061129366, 4375.890602734957, 4384.583464570861, 4386.18855511725, 4409.206342858252, 4494.235979883428, 9174.220191283815, 9205.401648892801, 9205.447673139633, 9219.354645174773, 9233.538323083952, 4928.507149285115, 4963.726995015237, 4966.553010229097, 4972.0, 4994.600431965434, 4499.0, 4549.54504549549, 4563.06457176278, 4564.0, 4567.995041090955, 3594.2272411431145, 3700.5929347771726, 3711.3319602471274, 3717.2937141942944, 3738.5513738351574, 1148.17905197784, 1169.2283093158644, 1172.8006238939402, 1175.9176857620055, 1177.664365655784, 962.9903700963041, 1003.3377970539409, 1049.4437947887632, 1058.899404556566, 1100.1583788401879, 7542.811429714301, 7732.30409263169, 7738.5356878586335, 7759.107702614158, 7763.611819409007, 1056.197290059545, 1091.0, 1153.1927650644416, 1161.715379731971, 1190.089581470176, 5903.881922361615, 5929.495992840571, 5973.910391344133, 5988.610740301867, 5991.872885125717, 9171.770705732277, 9678.661246856327, 9722.805543889224, 9739.951300243454, 9953.203743700487, 9866.851997220047, 9915.107640312406, 9916.900830991743, 9973.501324933724, 10024.19806415485, 7409.110906691231, 7570.394368450511, 7619.352355049772, 7640.197779233212, 7672.0, 7370.262973702587, 7459.104907411145, 7465.925340746523, 7481.438892083224, 7508.43686723487, 8442.197991190827, 8782.604782784661, 8833.205011548991, 8928.910710892807, 8951.865722014305, 8608.741737747878, 8766.21104100634, 8771.298296136421, 8792.29661627081, 8793.560321984003, 7037.577745335297, 7208.279172082959, 7216.9639151806, 7233.0, 7261.891071634035, 7612.733554325793, 7629.618519073913, 7643.808904777425, 7689.115751688404, 7763.767086987399, 7406.0001899745, 7506.3244308012545, 7540.472166948261, 7622.237776222333, 7661.233876612294, 7044.823879403056, 7063.36429721307, 7148.0350152728715, 7185.461090418135, 7355.485116041826, 7155.105611798525, 7156.105486814148, 7187.604681742345, 7202.96398518025, 7252.492325537161, 6385.10608514799, 6398.392152745481, 6461.19235095613, 6478.287388387368, 6488.12410324619, 6582.506312026713, 6647.734090636321, 6657.700403481952, 6666.766648170104, 6696.5647232929705], "unit": "score", "name": "mootools.html", "value": 4621.655321226749}, {"lowerIsBetter": false, "replicates": [316.51573093167445, 333.23190046941795, 335.7263829978569, 342.3529529189832, 343.7799808122802, 6295.866743986081, 6337.556371054028, 6338.0, 6348.714307856152, 6412.230532336114, 6198.81403557894, 6228.657423841687, 6267.498600111991, 6293.748250069992, 6301.40136687014, 4775.164346239403, 4789.6168306535565, 4791.257355109963, 4804.063207674505, 4816.975915120437, 4815.735134567597, 4816.157172494817, 4820.951790482103, 4825.348577941985, 4826.3001864729595, 4667.06658668266, 4731.1720448921305, 4733.881652958687, 4766.404199475066, 4767.213409787381, 4733.100710864925, 4742.09900118978, 4761.142994261032, 4777.044591081798, 4779.976100119477, 4181.602747738991, 4183.853565125237, 4189.455370801807, 4189.958100419018, 4195.951012246938, 6003.879922401527, 6025.548083893682, 6031.45716885478, 6037.335893051761, 6040.275166979946, 5446.455354464561, 5563.165525171256, 5571.582131340166, 5583.106702927553, 5585.050541407971, 6564.67176641166, 6564.967175164142, 6596.373344532261, 6605.801825945181, 6616.206055273398, 4619.514950930137, 4630.120277147331, 4646.767661616906, 4650.581447669692, 4652.046330502273, 6705.731770729214, 6866.279040700754, 6879.965600172017, 6896.310368963113, 6919.100516932817, 4537.886552836139, 4567.840125595588, 4573.954260457353, 4574.45106587205, 4584.931226031612, 4633.582977532038, 4636.095961287517, 4650.348951146842, 4651.488336283006, 4651.86044418668, 5405.054115529767, 5408.269883565747, 5410.215518749759, 5411.864703382447, 5412.675239485643, 6467.417932386108, 6645.1361323027695, 6648.4681225501845, 6711.966440167866, 6715.731370745116, 1600.7674090949904, 1626.146273206576, 1627.7965254343208, 1629.4867116858152, 1652.4959887234268, 1074.5486895503907, 1075.870895492546, 1087.211771465681, 1088.9183311251688, 1102.4102105373586, 6129.448349648553, 6167.0, 6193.111101114113, 6207.317195108534, 6220.03589443637, 6695.966520167368, 6715.731370745213, 6719.260881303053, 6737.9663101685155, 6745.966270168716, 6083.0, 6129.417705317987, 6149.938500615026, 6210.9068363974575, 6257.499400047986, 3634.5093412388987, 3640.9453858192146, 3660.3045421369857, 3670.596234414212, 3680.2087551176623, 6999.195092564319, 7004.754833580801, 7055.012298278245, 7064.399526040344, 7081.929180708127, 6680.665966701646, 6884.793456196322, 6898.206706228748, 6915.204751453547, 6933.965330173317, 6791.660416979132, 6845.5550389224545, 6873.20958089816, 6880.724771009103, 6901.378875901193, 6704.161979752531, 6716.3955244028275, 6730.73077076931, 6733.2593414725325, 6734.865302693821, 6515.051093590894, 6558.967205163944, 6601.405873471411, 6674.499412543982, 6686.0, 6988.231294557493, 6991.091158149408, 7019.719211231698, 7030.578165309893, 7047.929520704727, 4532.32015197723, 4605.424321959755, 4607.331936869068, 4613.746243956614, 4619.376384188226, 6769.052332673528, 6770.898436523357, 6781.593104413751, 6781.694823732845, 6924.688389022607, 6669.699408615274, 6670.533062685759, 6677.432418244503, 6677.833054173684, 6709.060731497691, 6672.199336079701, 6692.063111164343, 6693.129893114059, 6716.630585317855, 6737.3599508046655, 6407.359264073555, 6535.934640653532, 6570.967145164243, 6602.273749887605, 6607.372299631527, 6725.630090344882, 6728.831779205559, 6750.729970801113, 6772.424343930821, 6824.385805277549, 6524.119243902012, 6581.835454113494, 6583.670816459062, 6597.1423714916755, 6599.855047109804], "unit": "score", "name": "prototype.html", "value": 4958.953355850973}, {"lowerIsBetter": false, "replicates": [765.9846803063939, 832.0930186097155, 833.3083540661252, 838.1450920061537, 858.2018722587991, 13581.456741730331, 13652.590422287323, 13797.379117939692, 13814.723705525896, 14928.104313741183, 14218.075825071362, 14310.570682879505, 14320.140791552514, 14335.78496322556, 14364.138151710904, 794.2811755361407, 809.8096947217399, 809.9311558517533, 810.9538695083365, 811.8376324735048, 828.1345993436843, 830.3108420011406, 831.3266254334009, 831.3598529132564, 834.7036801935317, 842.9957850210741, 846.86026805577, 848.2789628815489, 851.7657644147878, 852.4160949749441, 833.5373867503533, 842.3682238321228, 845.6279237135672, 848.2916764501648, 851.3146916732028, 625.3652542669195, 626.505061001808, 626.5269721360389, 629.2574761781096, 631.9936800632026, 14067.226302553356, 14071.0, 14150.36323365451, 14151.71696566063, 14196.290185490685, 12231.571894983634, 12430.0, 12503.187292825936, 12519.678762878439, 12637.620871373874, 10418.27072104953, 10436.739081522946, 10453.372797632166, 10501.264911456201, 10608.840867386996, 3472.79791452343, 3490.5985811631735, 3502.807345595991, 3511.613722490524, 3591.5331006968927, 47020.0, 48554.27168592474, 48643.5135648646, 48986.51013489855, 51884.2217366736, 9504.714858554255, 9858.014198580084, 10163.44101074448, 10187.7453063674, 10350.792984140426, 16602.58493537647, 16768.83231167697, 16777.161141942855, 16793.91603041977, 17086.060266685203, 7349.118105827335, 7413.925860741431, 7428.257174282637, 7525.0, 7617.6572054256585, 3871.922561548753, 3917.275304068756, 3958.7426817256787, 3963.246983073207, 4070.8575199867864, 3018.109657650998, 3038.8328641924904, 3062.1732132324146, 3066.9725641909763, 3075.077476756964, 585.7130006296884, 600.8527910661916, 600.8587981824268, 602.9336772954971, 610.9755609775559, 605.3764622438895, 638.2213699286863, 641.9358064193543, 655.1875674164097, 693.1093544794915, 7944.887715719804, 8125.431219814556, 8130.796730081795, 8172.550509722022, 8256.050554186346, 518.9150500275899, 555.4336770307693, 595.330253464852, 609.1563184988822, 624.6782906803, 3860.517435320585, 3933.6066393361007, 3936.933487800892, 3969.622885825842, 4014.6186112319283, 51655.0, 52133.7393313031, 56592.151117733265, 57287.0, 57484.71257643768, 48514.0, 48524.7573762136, 48655.75672121617, 50125.74937125364, 50821.74589127031, 42902.0, 44156.0, 44243.778781106535, 44326.113477730265, 44386.11227775491, 7879.724209652634, 8026.197380261927, 8153.429259951747, 8754.69358572447, 8875.0, 32413.35173296568, 32816.835915820266, 32830.83584582062, 33429.66570334265, 33557.83221083977, 40165.79917100396, 41942.37086443767, 42156.57843421526, 43706.78146609246, 44038.55961440473, 10934.835977460503, 11119.16606254518, 11151.944240278746, 11222.382768947786, 11319.151063670093, 11455.713607159887, 11576.131790115607, 12027.639170824888, 12320.199187052813, 12869.678258043623, 10245.436500992517, 10255.538500767334, 10347.689569312932, 10619.1504679627, 10819.783604328028, 10705.518251678848, 10836.13310935139, 10993.065589424989, 11186.440677965906, 11202.831957520806, 9745.512724363613, 10597.841032384675, 10899.564017439214, 11179.776404472028, 11335.943320283346, 9277.814443711222, 9340.673076442292, 9351.672691455766, 9415.0, 9786.0, 8776.361277029915, 9131.406458580172, 9380.765480863032, 9754.170895473964, 9879.160271377013], "unit": "score", "name": "yui.html", "value": 6211.28760356738}], "name": "dromaeo_css", "value": 7064.939633940459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 113.0, 123.0, 111.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 154.0, 166.0, 130.0, 150.0, 149.0, 138.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 165.0, 164.0, 164.0, 164.0, 172.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 74.0, 74.0, 73.0, 144.0, 74.0, 73.0, 76.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [101.0, 99.0, 160.0, 96.0, 97.0, 97.0, 144.0, 97.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 113.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 114.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 149.0, 148.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 59.0, 60.0, 63.0, 69.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 87.0, 84.0, 85.0, 85.0, 92.0, 84.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 122.0, 113.0, 120.0, 119.0, 116.0, 122.0, 121.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [131.0, 145.0, 141.0, 139.0, 141.0, 130.0, 156.0, 144.0, 152.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 68.0, 66.0, 70.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1511.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [194.32568985619898], "unit": "score", "name": "DeltaBlue", "value": 340.2432279999999}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12612.5], "unit": "score", "name": "Boyer", "value": 52.84146679881068}, {"lowerIsBetter": false, "replicates": [41060.0], "unit": "score", "name": "RegExp", "value": 22.18667803214806}, {"lowerIsBetter": false, "replicates": [590.9090909090909], "unit": "score", "name": "Splay", "value": 137.9078461538462}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20227.322916458546}]} 13:13:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20227.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1511.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7064.94"}}} 13:13:46 INFO - Return code: 0 13:13:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:13:46 INFO - # TBPL SUCCESS # 13:13:46 INFO - Running post-action listener: _resource_record_post_action 13:13:46 INFO - Running post-run listener: _resource_record_post_run 13:13:47 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 561201152; Read time: 0; Write time: 830244 13:13:47 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 250327040; Read time: 0; Write time: 452520 13:13:47 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 310874112; Read time: 0; Write time: 377724 13:13:47 INFO - Running post-run listener: _upload_blobber_files 13:13:47 INFO - Blob upload gear active. 13:13:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:13:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:13:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:13:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:13:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:13:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:49 INFO - (blobuploader) - INFO - Done attempting. 13:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:13:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:49 INFO - (blobuploader) - INFO - Done attempting. 13:13:49 INFO - (blobuploader) - INFO - Iteration through files over. 13:13:49 INFO - Return code: 0 13:13:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:13:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:13:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f9b054ba508a1c7f5f382683607ca5156863abb65da9485354a67fd26aa8112b43183da165843f83861681e1d8c3da07467a0210d0517124aea384a7a6b214c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba6f30f8a1ae38887e7cf0e8118048de9d5f904e876d2bbe8c68b10157e52dbac995b9f1f923c374202eddc490e8b9f4a1350740057b85c7c7d47df9f4ba06e5"} 13:13:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:13:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:13:49 INFO - Contents: 13:13:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f9b054ba508a1c7f5f382683607ca5156863abb65da9485354a67fd26aa8112b43183da165843f83861681e1d8c3da07467a0210d0517124aea384a7a6b214c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba6f30f8a1ae38887e7cf0e8118048de9d5f904e876d2bbe8c68b10157e52dbac995b9f1f923c374202eddc490e8b9f4a1350740057b85c7c7d47df9f4ba06e5"} 13:13:49 INFO - Running post-run listener: copy_logs_to_upload_dir 13:13:49 INFO - Copying logs to upload dir... 13:13:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:13:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.402808 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-19 13:13:48.521758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 13:13:48.525897) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 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/7f9b054ba508a1c7f5f382683607ca5156863abb65da9485354a67fd26aa8112b43183da165843f83861681e1d8c3da07467a0210d0517124aea384a7a6b214c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba6f30f8a1ae38887e7cf0e8118048de9d5f904e876d2bbe8c68b10157e52dbac995b9f1f923c374202eddc490e8b9f4a1350740057b85c7c7d47df9f4ba06e5"} build_url:https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/FMtslBbJTTWqH4fSX_oe_g/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/7f9b054ba508a1c7f5f382683607ca5156863abb65da9485354a67fd26aa8112b43183da165843f83861681e1d8c3da07467a0210d0517124aea384a7a6b214c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba6f30f8a1ae38887e7cf0e8118048de9d5f904e876d2bbe8c68b10157e52dbac995b9f1f923c374202eddc490e8b9f4a1350740057b85c7c7d47df9f4ba06e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 13:13:48.553652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 13:13:48.554228) ========= 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=eca2ab57546de7b41f256b19000001ef-1453235429.734472-1846307639 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 13:13:48.636974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 13:13:48.637526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 13:13:48.638078) ========= ========= Total master_lag: 0.30 =========