builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1453215973.9 results: success (0) buildid: 20160119043050 builduid: e79441e3da554abfaaef2c3fb8092eef revision: f704088e0566c0d01e70a6d154cf0fe0bf343907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:13.898342) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:13.898909) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-01-19 07:06:13.899266) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test-pgo' ========= master_lag: 1.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-01-19 07:06:15.024641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.024958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.041388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.041783) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004767 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.092431) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.092982) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.093352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.103041) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 07:06:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-01-19 07:06:17 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.215457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.215777) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.265195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.265545) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f704088e0566c0d01e70a6d154cf0fe0bf343907 --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 f704088e0566c0d01e70a6d154cf0fe0bf343907 --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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 07:06:17,627 truncating revision to first 12 chars 2016-01-19 07:06:17,627 Setting DEBUG logging. 2016-01-19 07:06:17,627 attempt 1/10 2016-01-19 07:06:17,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f704088e0566?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 07:06:17,876 unpacking tar archive at: mozilla-inbound-f704088e0566/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.809198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.809522) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004290 script_repo_revision: '%(revision)s' ========= master_lag: 0.15 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.961463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.961763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.973884) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:15.974234) ========= 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 07:06:15.974672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-19 07:06:15.974949) ========= /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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:18 INFO - MultiFileLogger online at 20160119 07:06:18 in /builds/slave/test-pgo 07:06:18 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 07:06:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:06:18 INFO - {'append_to_log': False, 07:06:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:06:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:06:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:06:18 INFO - 'branch': 'Mozilla-Inbound', 07:06:18 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:18 INFO - 'config_files': ('talos/linux_config.py',), 07:06:18 INFO - 'default_actions': ('clobber', 07:06:18 INFO - 'read-buildbot-config', 07:06:18 INFO - 'download-and-extract', 07:06:18 INFO - 'populate-webroot', 07:06:18 INFO - 'create-virtualenv', 07:06:18 INFO - 'install', 07:06:18 INFO - 'run-tests'), 07:06:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:18 INFO - 'download_minidump_stackwalk': True, 07:06:18 INFO - 'download_symbols': 'ondemand', 07:06:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:18 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:18 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:18 INFO - 'installer_path': 'installer.exe', 07:06:18 INFO - 'log_level': 'info', 07:06:18 INFO - 'log_name': 'talos', 07:06:18 INFO - 'log_to_console': True, 07:06:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:18 INFO - 'opt_config_files': (), 07:06:18 INFO - 'pip_index': False, 07:06:18 INFO - 'sps_profile': False, 07:06:18 INFO - 'sps_profile_interval': 0, 07:06:18 INFO - 'suite': 'dromaeojs-e10s', 07:06:18 INFO - 'system_bits': '32', 07:06:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:18 INFO - 'title': 'talos-linux64-ix-048', 07:06:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:18 INFO - 'use_talos_json': True, 07:06:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:06:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:18 INFO - 'work_dir': 'build'} 07:06:18 INFO - ##### 07:06:18 INFO - ##### Running clobber step. 07:06:18 INFO - ##### 07:06:18 INFO - Running pre-action listener: _resource_record_pre_action 07:06:18 INFO - Running main action method: clobber 07:06:18 INFO - rmtree: /builds/slave/test-pgo/build 07:06:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:06:19 INFO - Running post-action listener: _resource_record_post_action 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running read-buildbot-config step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: read_buildbot_config 07:06:19 INFO - Using buildbot properties: 07:06:19 INFO - { 07:06:19 INFO - "project": "", 07:06:19 INFO - "product": "firefox", 07:06:19 INFO - "script_repo_revision": "production", 07:06:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:06:19 INFO - "repository": "", 07:06:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:06:19 INFO - "buildid": "20160119043050", 07:06:19 INFO - "pgo_build": "True", 07:06:19 INFO - "basedir": "/builds/slave/test-pgo", 07:06:19 INFO - "buildnumber": 635, 07:06:19 INFO - "slavename": "talos-linux64-ix-048", 07:06:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:06:19 INFO - "platform": "ubuntu64_hw", 07:06:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:06:19 INFO - "branch": "mozilla-inbound", 07:06:19 INFO - "repo_path": "integration/mozilla-inbound", 07:06:19 INFO - "revision": "f704088e0566c0d01e70a6d154cf0fe0bf343907", 07:06:19 INFO - "stage_platform": "linux64-pgo", 07:06:19 INFO - "builduid": "e79441e3da554abfaaef2c3fb8092eef", 07:06:19 INFO - "slavebuilddir": "test" 07:06:19 INFO - } 07:06:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:06:19 INFO - Running post-action listener: _resource_record_post_action 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running download-and-extract step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: download_and_extract 07:06:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:06:19 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')]} 07:06:19 INFO - https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/test_packages.json 07:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/test_packages.json 07:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:06:21 INFO - Downloaded 1448 bytes. 07:06:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:06:21 INFO - Using the following test package requirements: 07:06:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'jsshell-linux-x86_64.zip'], 07:06:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:21 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')]} 07:06:21 INFO - https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:27 INFO - Downloaded 22484469 bytes. 07:06:27 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'] 07:06:27 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 07:06:28 INFO - Return code: 0 07:06:28 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 07:06:28 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')]} 07:06:28 INFO - https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:30 INFO - Downloaded 22484469 bytes. 07:06:30 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'] 07:06:30 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 07:06:32 INFO - Return code: 0 07:06:32 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')]} 07:06:32 INFO - https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:33 INFO - Downloaded 11132144 bytes. 07:06:33 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'] 07:06:33 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 07:06:33 INFO - Return code: 0 07:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:33 INFO - https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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 07:06:34 INFO - Downloaded 55917269 bytes. 07:06:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:34 INFO - mkdir: /builds/slave/test-pgo/properties 07:06:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:06:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:06:34 INFO - Contents: 07:06:34 INFO - build_url:https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:06:34 INFO - Running post-action listener: _resource_record_post_action 07:06:34 INFO - Running post-action listener: set_extra_try_arguments 07:06:34 INFO - ##### 07:06:34 INFO - ##### Running populate-webroot step. 07:06:34 INFO - ##### 07:06:34 INFO - Running pre-action listener: _resource_record_pre_action 07:06:34 INFO - Running main action method: populate_webroot 07:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:34 INFO - '--tppagecycles', 07:06:34 INFO - '7'], 07:06:34 INFO - 'tests': ['tsvgm']}}, 07:06:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:06:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['damp', 'tps']}, 07:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['damp', 'tps']}, 07:06:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:34 INFO - 'other': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'other_l64': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'other_nol64': {'tests': ['a11yr', 07:06:34 INFO - 'ts_paint', 07:06:34 INFO - 'tpaint', 07:06:34 INFO - 'sessionrestore', 07:06:34 INFO - 'sessionrestore_no_auto_restore']}, 07:06:34 INFO - 'svgr': {'tests': ['tsvgx', 07:06:34 INFO - 'tsvgr_opacity', 07:06:34 INFO - 'tart', 07:06:34 INFO - 'tscrollx', 07:06:34 INFO - 'cart']}, 07:06:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['tsvgx', 07:06:34 INFO - 'tsvgr_opacity', 07:06:34 INFO - 'tart', 07:06:34 INFO - 'tscrollx', 07:06:34 INFO - 'cart']}, 07:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'tests': ['tp5o']}, 07:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--e10s'], 07:06:34 INFO - 'tests': ['tp5o']}, 07:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--xperf_path', 07:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:34 INFO - 'tests': ['tp5n']}, 07:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:34 INFO - 'talos_options': ['--e10s', 07:06:34 INFO - '--xperf_path', 07:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:34 INFO - 'tests': ['tp5n']}}, 07:06:34 INFO - 'talos.zip': {'path': '', 07:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:34 INFO - Running post-action listener: _resource_record_post_action 07:06:34 INFO - ##### 07:06:34 INFO - ##### Running create-virtualenv step. 07:06:34 INFO - ##### 07:06:34 INFO - Running pre-action listener: _resource_record_pre_action 07:06:34 INFO - Running main action method: create_virtualenv 07:06:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:06:34 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 07:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:34 INFO - Using real prefix '/usr' 07:06:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:37 INFO - Installing pip.................done. 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:06:37 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')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 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')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:37 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 07:06:37 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 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 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 07:06:37 INFO - Cleaning up... 07:06:37 INFO - Return code: 0 07:06:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:06:37 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')]} 07:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 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')]} 07:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:37 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:37 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 07:06:37 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 07:06:37 INFO - Using env: {'DISPLAY': ':0', 07:06:37 INFO - 'HOME': '/home/cltbld', 07:06:37 INFO - 'LANG': 'en_US.UTF-8', 07:06:37 INFO - 'LANGUAGE': 'en_US:en', 07:06:37 INFO - 'LOGNAME': 'cltbld', 07:06:37 INFO - 'MAIL': '/var/mail/cltbld', 07:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:37 INFO - 'MOZ_NO_REMOTE': '1', 07:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:37 INFO - 'NO_EM_RESTART': '1', 07:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:37 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:37 INFO - 'SHELL': '/bin/bash', 07:06:37 INFO - 'SHLVL': '1', 07:06:37 INFO - 'TERM': 'linux', 07:06:37 INFO - 'TMOUT': '86400', 07:06:37 INFO - 'USER': 'cltbld', 07:06:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:37 INFO - '_': '/tools/buildbot/bin/python'} 07:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:37 INFO - Downloading/unpacking psutil>=0.7.1 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:37 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 07:06:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:06:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:06:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:39 INFO - Installing collected packages: psutil 07:06:39 INFO - Running setup.py install for psutil 07:06:39 INFO - building 'psutil._psutil_linux' extension 07:06:39 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 07:06:39 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 07:06:39 INFO - building 'psutil._psutil_posix' extension 07:06:39 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 07:06:39 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 07:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:40 INFO - Successfully installed psutil 07:06:40 INFO - Cleaning up... 07:06:40 INFO - Return code: 0 07:06:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:06:40 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')]} 07:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:40 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')]} 07:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:40 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:40 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 07:06:40 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 07:06:40 INFO - Using env: {'DISPLAY': ':0', 07:06:40 INFO - 'HOME': '/home/cltbld', 07:06:40 INFO - 'LANG': 'en_US.UTF-8', 07:06:40 INFO - 'LANGUAGE': 'en_US:en', 07:06:40 INFO - 'LOGNAME': 'cltbld', 07:06:40 INFO - 'MAIL': '/var/mail/cltbld', 07:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:40 INFO - 'MOZ_NO_REMOTE': '1', 07:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:40 INFO - 'NO_EM_RESTART': '1', 07:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:40 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:40 INFO - 'SHELL': '/bin/bash', 07:06:40 INFO - 'SHLVL': '1', 07:06:40 INFO - 'TERM': 'linux', 07:06:40 INFO - 'TMOUT': '86400', 07:06:40 INFO - 'USER': 'cltbld', 07:06:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:40 INFO - '_': '/tools/buildbot/bin/python'} 07:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:40 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 07:06:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:06:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:06:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:06:42 INFO - Installing collected packages: mozsystemmonitor 07:06:42 INFO - Running setup.py install for mozsystemmonitor 07:06:42 INFO - Successfully installed mozsystemmonitor 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:06: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')]} 07:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:42 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 07:06:42 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 07:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:42 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 07:06:44 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:06:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 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 07:06:44 INFO - Downloading docopt-0.6.1.tar.gz 07:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:45 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:45 INFO - Running setup.py install for blobuploader 07:06:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:06:45 INFO - Running setup.py install for requests 07:06:45 INFO - Running setup.py install for docopt 07:06:45 INFO - Successfully installed blobuploader requests docopt 07:06:45 INFO - Cleaning up... 07:06:45 INFO - Return code: 0 07:06:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06: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')]} 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:45 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 07:06:45 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 07:06:45 INFO - Using env: {'DISPLAY': ':0', 07:06:45 INFO - 'HOME': '/home/cltbld', 07:06:45 INFO - 'LANG': 'en_US.UTF-8', 07:06:45 INFO - 'LANGUAGE': 'en_US:en', 07:06:45 INFO - 'LOGNAME': 'cltbld', 07:06:45 INFO - 'MAIL': '/var/mail/cltbld', 07:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:45 INFO - 'MOZ_NO_REMOTE': '1', 07:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:45 INFO - 'NO_EM_RESTART': '1', 07:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:45 INFO - 'SHELL': '/bin/bash', 07:06:45 INFO - 'SHLVL': '1', 07:06:45 INFO - 'TERM': 'linux', 07:06:45 INFO - 'TMOUT': '86400', 07:06:45 INFO - 'USER': 'cltbld', 07:06:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:45 INFO - '_': '/tools/buildbot/bin/python'} 07:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:45 INFO - Running setup.py (path:/tmp/pip-JEWb_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:45 INFO - Running setup.py (path:/tmp/pip-EZqnT3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:45 INFO - Running setup.py (path:/tmp/pip-CKfKcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:46 INFO - Running setup.py (path:/tmp/pip-T11pVu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:46 INFO - Running setup.py (path:/tmp/pip-GfOdBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:46 INFO - Running setup.py (path:/tmp/pip-aqTMRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:46 INFO - Running setup.py (path:/tmp/pip-cSuRiI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:46 INFO - Running setup.py (path:/tmp/pip-N8YDHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:46 INFO - Running setup.py (path:/tmp/pip-Si4faE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:46 INFO - Running setup.py (path:/tmp/pip-H1n7YS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:46 INFO - Running setup.py (path:/tmp/pip-xiApmh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:46 INFO - Running setup.py (path:/tmp/pip-mTEl4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:46 INFO - Running setup.py (path:/tmp/pip-LVMDVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:46 INFO - Running setup.py (path:/tmp/pip-GXf_Wi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:46 INFO - Running setup.py (path:/tmp/pip-WBuTPg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:46 INFO - Running setup.py (path:/tmp/pip-1RZPV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:46 INFO - Running setup.py (path:/tmp/pip-jhcUA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:47 INFO - Running setup.py install for manifestparser 07:06:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Running setup.py install for mozcrash 07:06:47 INFO - Running setup.py install for mozdebug 07:06:47 INFO - Running setup.py install for mozdevice 07:06:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Running setup.py install for mozfile 07:06:47 INFO - Running setup.py install for mozhttpd 07:06:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Running setup.py install for mozinfo 07:06:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Running setup.py install for mozInstall 07:06:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:06:47 INFO - Running setup.py install for mozleak 07:06:47 INFO - Running setup.py install for mozlog 07:06:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Running setup.py install for moznetwork 07:06:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Running setup.py install for mozprocess 07:06:48 INFO - Running setup.py install for mozprofile 07:06:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Running setup.py install for mozrunner 07:06:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Running setup.py install for mozscreenshot 07:06:48 INFO - Running setup.py install for moztest 07:06:48 INFO - Running setup.py install for mozversion 07:06:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:06:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:48 INFO - Cleaning up... 07:06:48 INFO - Return code: 0 07:06:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06: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')]} 07:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:48 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:48 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 07:06:48 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 07:06:48 INFO - Using env: {'DISPLAY': ':0', 07:06:48 INFO - 'HOME': '/home/cltbld', 07:06:48 INFO - 'LANG': 'en_US.UTF-8', 07:06:48 INFO - 'LANGUAGE': 'en_US:en', 07:06:48 INFO - 'LOGNAME': 'cltbld', 07:06:48 INFO - 'MAIL': '/var/mail/cltbld', 07:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:48 INFO - 'MOZ_NO_REMOTE': '1', 07:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:48 INFO - 'NO_EM_RESTART': '1', 07:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:48 INFO - 'SHELL': '/bin/bash', 07:06:48 INFO - 'SHLVL': '1', 07:06:48 INFO - 'TERM': 'linux', 07:06:48 INFO - 'TMOUT': '86400', 07:06:48 INFO - 'USER': 'cltbld', 07:06:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:48 INFO - '_': '/tools/buildbot/bin/python'} 07:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:49 INFO - Running setup.py (path:/tmp/pip-19xm49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:49 INFO - Running setup.py (path:/tmp/pip-9ELs41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:49 INFO - Running setup.py (path:/tmp/pip-zdFKIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:49 INFO - Running setup.py (path:/tmp/pip-Bf_WZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:49 INFO - Running setup.py (path:/tmp/pip-FJhhSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:49 INFO - Running setup.py (path:/tmp/pip-2JNUIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:49 INFO - Running setup.py (path:/tmp/pip-zZxrJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:49 INFO - Running setup.py (path:/tmp/pip-EKlARI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:49 INFO - Running setup.py (path:/tmp/pip-fv3Tb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:49 INFO - Running setup.py (path:/tmp/pip-QTkYev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:49 INFO - Running setup.py (path:/tmp/pip-Zl2L6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:49 INFO - Running setup.py (path:/tmp/pip-E330qv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:06:49 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)) 07:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:49 INFO - Running setup.py (path:/tmp/pip-_rlZPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:50 INFO - Running setup.py (path:/tmp/pip-fXlJtl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:50 INFO - Running setup.py (path:/tmp/pip-6emD9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:50 INFO - Running setup.py (path:/tmp/pip-D4DGJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:06:50 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)) 07:06:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:50 INFO - Running setup.py (path:/tmp/pip-FR7aIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 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)) 07:06:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:51 INFO - Downloading blessings-1.5.1.tar.gz 07:06:51 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 07:06:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:52 INFO - Installing collected packages: blessings 07:06:52 INFO - Running setup.py install for blessings 07:06:52 INFO - Successfully installed blessings 07:06:52 INFO - Cleaning up... 07:06:52 INFO - Return code: 0 07:06:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:06:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:52 INFO - Reading from file tmpfile_stdout 07:06:52 INFO - Current package versions: 07:06:52 INFO - argparse == 1.2.1 07:06:52 INFO - blessings == 1.5.1 07:06:52 INFO - blobuploader == 1.2.4 07:06:52 INFO - docopt == 0.6.1 07:06:52 INFO - manifestparser == 1.1 07:06:52 INFO - mozInstall == 1.12 07:06:52 INFO - mozcrash == 0.16 07:06:52 INFO - mozdebug == 0.1 07:06:52 INFO - mozdevice == 0.48 07:06:52 INFO - mozfile == 1.2 07:06:52 INFO - mozhttpd == 0.7 07:06:52 INFO - mozinfo == 0.9 07:06:52 INFO - mozleak == 0.1 07:06:52 INFO - mozlog == 3.1 07:06:52 INFO - moznetwork == 0.27 07:06:52 INFO - mozprocess == 0.22 07:06:52 INFO - mozprofile == 0.28 07:06:52 INFO - mozrunner == 6.11 07:06:52 INFO - mozscreenshot == 0.1 07:06:52 INFO - mozsystemmonitor == 0.0 07:06:52 INFO - moztest == 0.7 07:06:52 INFO - mozversion == 1.4 07:06:52 INFO - psutil == 3.1.1 07:06:52 INFO - requests == 1.2.3 07:06:52 INFO - wsgiref == 0.1.2 07:06:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:52 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:52 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 07:06:52 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 07:06:52 INFO - Using env: {'DISPLAY': ':0', 07:06:52 INFO - 'HOME': '/home/cltbld', 07:06:52 INFO - 'LANG': 'en_US.UTF-8', 07:06:52 INFO - 'LANGUAGE': 'en_US:en', 07:06:52 INFO - 'LOGNAME': 'cltbld', 07:06:52 INFO - 'MAIL': '/var/mail/cltbld', 07:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:52 INFO - 'MOZ_NO_REMOTE': '1', 07:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:52 INFO - 'NO_EM_RESTART': '1', 07:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:52 INFO - 'SHELL': '/bin/bash', 07:06:52 INFO - 'SHLVL': '1', 07:06:52 INFO - 'TERM': 'linux', 07:06:52 INFO - 'TMOUT': '86400', 07:06:52 INFO - 'USER': 'cltbld', 07:06:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:52 INFO - '_': '/tools/buildbot/bin/python'} 07:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 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)) 07:06:52 INFO - Cleaning up... 07:06:52 INFO - Return code: 0 07:06:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:52 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 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:52 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 07:06:52 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 07:06:52 INFO - Using env: {'DISPLAY': ':0', 07:06:52 INFO - 'HOME': '/home/cltbld', 07:06:52 INFO - 'LANG': 'en_US.UTF-8', 07:06:52 INFO - 'LANGUAGE': 'en_US:en', 07:06:52 INFO - 'LOGNAME': 'cltbld', 07:06:52 INFO - 'MAIL': '/var/mail/cltbld', 07:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:52 INFO - 'MOZ_NO_REMOTE': '1', 07:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:52 INFO - 'NO_EM_RESTART': '1', 07:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:52 INFO - 'SHELL': '/bin/bash', 07:06:52 INFO - 'SHLVL': '1', 07:06:52 INFO - 'TERM': 'linux', 07:06:52 INFO - 'TMOUT': '86400', 07:06:52 INFO - 'USER': 'cltbld', 07:06:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:52 INFO - '_': '/tools/buildbot/bin/python'} 07:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:52 INFO - Downloading/unpacking jsonschema 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:54 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 07:06:54 INFO - Downloading/unpacking functools32 (from jsonschema) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:54 INFO - warning: no files found matching '*.txt' 07:06:54 INFO - no previously-included directories found matching 'build' 07:06:54 INFO - no previously-included directories found matching 'dist' 07:06:54 INFO - no previously-included directories found matching '.git*' 07:06:54 INFO - Installing collected packages: jsonschema, functools32 07:06:54 INFO - Running setup.py install for functools32 07:06:55 INFO - warning: no files found matching '*.txt' 07:06:55 INFO - no previously-included directories found matching 'build' 07:06:55 INFO - no previously-included directories found matching 'dist' 07:06:55 INFO - no previously-included directories found matching '.git*' 07:06:55 INFO - Successfully installed jsonschema functools32 07:06:55 INFO - Cleaning up... 07:06:55 INFO - Return code: 0 07:06:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb20cb78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b65230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, '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': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', '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 07:06:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:06:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:06:55 INFO - Using env: {'DISPLAY': ':0', 07:06:55 INFO - 'HOME': '/home/cltbld', 07:06:55 INFO - 'LANG': 'en_US.UTF-8', 07:06:55 INFO - 'LANGUAGE': 'en_US:en', 07:06:55 INFO - 'LOGNAME': 'cltbld', 07:06:55 INFO - 'MAIL': '/var/mail/cltbld', 07:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:55 INFO - 'MOZ_NO_REMOTE': '1', 07:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:55 INFO - 'NO_EM_RESTART': '1', 07:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:55 INFO - 'SHELL': '/bin/bash', 07:06:55 INFO - 'SHLVL': '1', 07:06:55 INFO - 'TERM': 'linux', 07:06:55 INFO - 'TMOUT': '86400', 07:06:55 INFO - 'USER': 'cltbld', 07:06:55 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:55 INFO - '_': '/tools/buildbot/bin/python'} 07:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:55 INFO - Downloading/unpacking flake8 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:06:56 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 07:06:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:06:57 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 07:06:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:57 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 07:06:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06: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 07:06:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:57 INFO - no previously-included directories found matching 'docs/_build' 07:06:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:06:57 INFO - Running setup.py install for pep8 07:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:57 INFO - no previously-included directories found matching 'docs/_build' 07:06:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:06:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:06:57 INFO - Cleaning up... 07:06:57 INFO - Return code: 0 07:06:57 INFO - Running post-action listener: _resource_record_post_action 07:06:57 INFO - Running post-action listener: _start_resource_monitoring 07:06:57 INFO - Starting resource monitoring. 07:06:57 INFO - ##### 07:06:57 INFO - ##### Running install step. 07:06:57 INFO - ##### 07:06:57 INFO - Running pre-action listener: _resource_record_pre_action 07:06:57 INFO - Running main action method: install 07:06:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:58 INFO - Reading from file tmpfile_stdout 07:06:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:06:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:06:58 INFO - Reading from file tmpfile_stdout 07:06:58 INFO - Output received: 07:06:58 INFO - Usage: mozinstall [options] installer 07:06:58 INFO - Options: 07:06:58 INFO - -h, --help show this help message and exit 07:06:58 INFO - -d DEST, --destination=DEST 07:06:58 INFO - Directory to install application into. [default: 07:06:58 INFO - "/builds/slave/test-pgo"] 07:06:58 INFO - --app=APP Application being installed. [default: firefox] 07:06:58 INFO - mkdir: /builds/slave/test-pgo/build/application 07:06:58 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'] 07:06:58 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 07:07:14 INFO - Reading from file tmpfile_stdout 07:07:14 INFO - Output received: 07:07:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:07:14 INFO - Running post-action listener: _resource_record_post_action 07:07:14 INFO - ##### 07:07:14 INFO - ##### Running run-tests step. 07:07:14 INFO - ##### 07:07:14 INFO - Running pre-action listener: _resource_record_pre_action 07:07:14 INFO - Running main action method: run_tests 07:07:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:07:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:07:14 INFO - Python 2.7.3 07:07:14 INFO - Return code: 0 07:07:14 INFO - grabbing minidump binary from tooltool 07:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:14 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 0x2bf77f0>, '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 0x2b632d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b63760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:07:14 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 07:07:14 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 07:07:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:14 INFO - Return code: 0 07:07:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:07:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:07:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:07:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:07:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:07:15 INFO - Return code: 0 07:07:15 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/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 07:07:15 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/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 07:07:15 INFO - Using env: {'DISPLAY': ':0', 07:07:15 INFO - 'HOME': '/home/cltbld', 07:07:15 INFO - 'LANG': 'en_US.UTF-8', 07:07:15 INFO - 'LANGUAGE': 'en_US:en', 07:07:15 INFO - 'LOGNAME': 'cltbld', 07:07:15 INFO - 'MAIL': '/var/mail/cltbld', 07:07:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:15 INFO - 'MOZ_NO_REMOTE': '1', 07:07:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:15 INFO - 'NO_EM_RESTART': '1', 07:07:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:07:15 INFO - 'SHELL': '/bin/bash', 07:07:15 INFO - 'SHLVL': '1', 07:07:15 INFO - 'TERM': 'linux', 07:07:15 INFO - 'TMOUT': '86400', 07:07:15 INFO - 'USER': 'cltbld', 07:07:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002', 07:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:15 INFO - '_': '/tools/buildbot/bin/python'} 07:07:15 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/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 07:07:15 INFO - mozversion application_buildid: 20160119043050 07:07:15 INFO - mozversion application_changeset: f704088e0566c0d01e70a6d154cf0fe0bf343907 07:07:15 INFO - mozversion application_display_name: Nightly 07:07:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:15 INFO - mozversion application_name: Firefox 07:07:15 INFO - mozversion application_remotingname: firefox 07:07:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:15 INFO - mozversion application_vendor: Mozilla 07:07:15 INFO - mozversion application_version: 46.0a1 07:07:15 INFO - mozversion platform_buildid: 20160119043050 07:07:15 INFO - mozversion platform_changeset: f704088e0566c0d01e70a6d154cf0fe0bf343907 07:07:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:15 INFO - mozversion platform_version: 46.0a1 07:07:15 INFO - using testdate: 1453216035 07:07:15 INFO - actual date: 1453216035 07:07:15 INFO - starting webserver on 'localhost:59159' 07:07:15 INFO - SUITE-START | Running 3 tests 07:07:15 INFO - TEST-START | dromaeo_css 07:07:15 INFO - operating with platform_type : linux_ 07:07:15 INFO - Initialising browser for dromaeo_css test... 07:07:15 INFO - TEST-INFO | started process 29497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX9es8Q/profile http://localhost:59159/getInfo.html) 07:07:19 INFO - PROCESS | 29497 | 07:07:19 INFO - PROCESS | 29497 | (process:29579): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:07:20 INFO - PROCESS | 29497 | __metrics Screen width/height:1600/1200 07:07:20 INFO - PROCESS | 29497 | colorDepth:24 07:07:20 INFO - PROCESS | 29497 | Browser inner width/height: 1024/697 07:07:20 INFO - PROCESS | 29497 | __metrics 07:07:20 INFO - PROCESS | 29497 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:07:21 INFO - TEST-INFO | 29497: exit 0 07:07:21 INFO - Browser initialized. 07:07:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:21 INFO - TEST-INFO | started process 29628 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX9es8Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:21 INFO - PROCESS | 29628 | -- checkerboarding starts below -- 07:07:21 INFO - PROCESS | 29628 | RENDERTRACE 0.075612 rect red 0 0 10 10 // viewport 07:07:21 INFO - PROCESS | 29628 | RENDERTRACE 4.78035 rect red 0 0 10 10 // viewport 07:07:21 INFO - PROCESS | 29628 | RENDERTRACE 22.2115 rect brown 0 0 10 10 // page 07:07:21 INFO - PROCESS | 29628 | RENDERTRACE 22.2332 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 07:07:21 INFO - PROCESS | 29628 | Checkerboarded for 2 frames (24.9867 ms), 100 peak, 477 severity. 07:07:22 INFO - PROCESS | 29628 | 07:07:22 INFO - PROCESS | 29628 | (process:29688): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:07:33 INFO - PROCESS | 29628 | RSS: Main: 150122496 07:07:33 INFO - PROCESS | 29628 | 07:08:22 INFO - PROCESS | 29628 | 1453216102708 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] 07:10:31 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59159/tests/dromaeo/cssquery-ext.html) 07:10:32 INFO - PROCESS | 29628 | RSS: Main: 156422144 07:10:32 INFO - PROCESS | 29628 | 07:13:34 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-ext.html (next: http://localhost:59159/tests/dromaeo/cssquery-jquery.html) 07:13:35 INFO - PROCESS | 29628 | RSS: Main: 151646208 07:13:35 INFO - PROCESS | 29628 | 07:16:36 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59159/tests/dromaeo/cssquery-mootools.html) 07:16:37 INFO - PROCESS | 29628 | RSS: Main: 151101440 07:16:37 INFO - PROCESS | 29628 | 07:19:39 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59159/tests/dromaeo/cssquery-prototype.html) 07:19:39 INFO - PROCESS | 29628 | RSS: Main: 150814720 07:19:39 INFO - PROCESS | 29628 | 07:22:42 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59159/tests/dromaeo/cssquery-yui.html) 07:22:42 INFO - PROCESS | 29628 | RSS: Main: 151232512 07:22:42 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | Cycle 1(1): loaded http://localhost:59159/tests/dromaeo/cssquery-yui.html (next: http://localhost:59159/tests/dromaeo/cssquery-dojo.html) 07:25:45 INFO - PROCESS | 29628 | RSS: Main: 152965120 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | __start_tp_report 07:25:45 INFO - PROCESS | 29628 | _x_x_mozilla_page_load 07:25:45 INFO - PROCESS | 29628 | _x_x_mozilla_page_load_details 07:25:45 INFO - PROCESS | 29628 | |i|pagename|runs| 07:25:45 INFO - PROCESS | 29628 | |0;dojo.html;3080.414721202971;3097.7918611741425;3130.733887619552;3131.5928929239208;3146.1505393543744;4923.581495572872;5171.276021357008;5182;5184.999999999995;5237.685738855662;5102.285680004802;5262.842114736564;5267.1045922193225;5276.9208461873;5298.576113910887;4680.134175177603;4717.9292310615365;4830.275458681208;4830.420349558058;4850.223964165734;4639.976800115995;4763.666543341968;4813.15769740294;4819.734914579697;4857.73282469464;4622;4630.37489938859;4644.744539050368;4742.1227072991605;4784.928226076577;4779.378680771478;4784.378030855966;4785.497522760095;4809.038192361541;4822.445418776851;4662.906741865144;4712.929306060412;4725.905481890377;4738.763061846894;4762.333273341735;4952.33143525623;5019.272205530177;5069.974650126763;5126.897462050738;5211.296474975906;5560.527355174815;5572.693501857396;5574.777008919638;5576.776928922838;5596.27248457702;5505.394406615269;5646.943530564683;5651.237082993825;5653.632513886584;5707.942920570783;5141.562967147797;5186.611004174702;5191.766370513336;5264.973675131638;5275.868103297372;5686.516646085129;5692.8861422771315;5699;5699.344575373885;5719.48524632785;5357.919631205535;5433.809816656477;5450.182472629137;5493.423190565013;5531.474509921551;5434.049041417815;5541.501264886179;5591.8602034948635;5603.971980140073;5663.575231857627;5527.55779537636;5533.280673512418;5549.001179787596;5549.5837812164245;5551.111822108443;5444.537214336747;5500.944990550123;5521.723913804374;5534.142207957773;5615.747291371898;4374.62815660666;4408.338749187584;4414.3157810539415;4428.82284708608;4441;3837.3668344723364;3852.768833869977;3863.36254518007;3865.9226815464094;3933.6066393360434;5065.898682026339;5142.61430392722;5194.506521880416;5214.191800270964;5277.920831187535;5615.663060216319;5631.605787594911;5639.6334238274385;5657.519110875622;5665.716714164275;5201.375834899836;5249.921251181236;5253.474652534793;5271.894562108736;5313.548348390353;4685.273782563708;4761.809527618926;4764.928526072112;4772.856814295576;4842.225243960949;5745.9425405745405;5836.649801011953;5844.912326315109;5855.3266374367495;5874.823755287348;5490.890182196254;5524.254225679482;5537.723113844211;5555.22226888244;5579.079451890392;5414.620976531605;5442.319710036246;5718.971405142947;5727.284089488814;5779.682117483579;5447.210154527492;5501.5323697486165;5509.944900551103;5519.862003449946;5555.638883472561;5553.805616803393;5609.579281553982;5616.943830561642;5625.043742563692;5637.238972738628;5347.117725575236;5351.090314646442;5427.592930530305;5469.617126801086;5523.530499907552;5427.375851776938;5481.671099734029;5487.972560137174;5498.862528436821;5519.39286678473;5394;5400.1089820180805;5412.891742165213;5413.83758487246;5463.754131064032;5305.018571564273;5412.107002344569;5417.620766546304;5513.228148059195;5516.779328826962;5403.162509810985;5443.101888188405;5449.782008719765;5456.236126942152;5473.480019398151 07:25:45 INFO - PROCESS | 29628 | |1;ext.html;531.2350215689405;534.1800336483498;536.9677819330841;551.5449753952988;575.0597772641732;34796.13009674756;35443.1139221519;35655.4651680225;35771.10572235695;35840;38328.42507362385;38785;39000.41499377511;39020;39070;8436.282915952135;8542.462356775777;8591.398602097855;8639.352048596349;8644.567771611426;8341.624626891775;8447.113053129426;8549.230569248766;8617.353698472609;8706.738797836075;8504.829903401927;8660.090690477504;8704.390692651517;8719.825603487927;8731.388802783807;8561.0582835888;8677.652893884237;8697.260732837716;8705.390622656416;8711.477311361306;7485;8596.183362580545;8631.093735157781;8674.479531228146;8683.826323473495;38914.80542597297;38931.8053409734;39275.41086883699;39515.802420987995;39556.80221598873;2974.803415074317;3163.398954198695;3187.139472342478;3340.9391256143626;3963.7027222958395;28566.143015709564;29196.41607167866;29372.265693357836;29576.26059348512;30370.088897333117;3686.2430164136044;3827.655511004023;3885.9028524286837;3920.6275403836876;3933.4886464759684;263582;263736;263756;264216;265273;40919.38620920689;41445.79277103595;56860;57231.14153287704;57249;42183;42455.36316955248;42698.359524607156;42701.35947960783;42849.785751071046;12871.806922896165;12990.935045324903;13005.284709340887;13067;13081.084324097412;9938.900610993798;9949.651762188289;9989;10034.147097496794;10061.798764024825;14063.367148478139;14071.71856562863;14093.506727264497;14123.858761412459;14214;5623.578231632562;5659.660420374791;5739.053056245756;5793.217915581343;5828.88342233153;914.1635403605626;932;947.8767760191131;1024.4314405504867;1071.9709079283818;27928.72071279302;27966.580501292498;28074.29814254619;28093.752499799968;28493.715062849522;1027.7995790820867;1057.9896199129812;1113.2263077161458;1120.3781901045;1161.7560312334504;14432.639184020483;14722.705545889237;14772.556823295103;14844.851551484348;14889.702205956037;726441;742628;746535;749226;750502;52941.20588191103;52974;53247.46752532425;53412.46587534153;53471.732641336544;1306.7713150198676;1308.149702693238;1312.9277889715966;1317.6639956810952;1321.6101250131235;28820;29594.704052959194;29698.55452168176;30176.24559386033;30404.847975759978;45151.548484516046;45165.09669806651;45564.772176138904;45750.54249457463;45771;296507;296574;297547;297989;299361;32199.356012879143;42581.57418425776;43262.351064733426;43510.34734478922;43587.34618980654;37904;38483.61516384912;38524.42213366858;38533.614663853004;39053.80473097616;32511.674883250864;33209.50185747264;33314;33484;33702.66297336995;33111;38474.61525384822;39759.80120099381;40097;43179.13641727211;34961.8251908749;35655.64344356627;35739.28521429609;35769.82115089408;36153;30662.386752265276;32357.029289121365;32417.675823241465;33088.67645294161;33110;24225.75774242235;24689;24720.13479528208;25040.123595674064;25147.49705005926 07:25:45 INFO - PROCESS | 29628 | |2;jquery.html;363.1375483227333;365.9652333028363;367.5956447907302;367.9595244523103;371.6970668904844;15696.764548531766;16234.188290585482;16479.258433370498;17002;17361.82638173618;15088.094714317122;15118.092914425115;15182.772258416133;16115.435959741382;16201;4812.6390520711;5003.574696150831;5004.849854504352;5007.474215207405;5026.170681837492;4258.659307255412;4907.6073914086965;4941.258811178334;4994.550490455877;5425.6202065855405;5014.774335154909;5159.5614372778355;5178.948210517884;5405.270288511059;5431.158170483582;5013.373328333958;5108.8211912583065;5133.844884900905;5166.535011848933;5273.182656688219;5128.71792051437;5136.383633963948;5139.383274007106;5139.897202055975;5143.3313669223135;11790.410479475991;19138;19642.017899104987;19691.90154049235;19915.302964396178;2004.3586052463218;2146.152269853415;2159.255057005331;2224.877631730254;2265.784750448705;8994.685186018458;9168.724938251797;9186.63253469867;9212.769680757967;9257.814843703156;1759.5864971731633;1764.1708397053364;1773.733939909011;1799.595091104504;1837.7610910581673;52947.73526132383;53798.73100634511;54678.72660636671;55474.44525554733;55488;9404.200642945427;9515.476648784244;9859.211263098934;9910;9936.453495057696;12757.617271481871;12772.552960646333;12774.169678970837;12791.744165116646;12889.419976101099;6865.828354291183;6883.7590684325805;6891.138607674041;6926.61903595297;6956.582605043714;6477.255115661665;6479.740810367627;6513.674316284261;6520.510961677893;6521.11964884744;4224.957750422518;4304.569543045671;4371.78141092944;4475.955240447619;4524.524924882906;1799.6850551153757;1839.2343350383514;1842.6959551674092;1855.9072046397896;1902.8192321729414;842.4315276025467;877.7630039889322;942.9009953954874;947.251671179774;972.0716715536787;15295.388184472497;15319.31063102163;15354.309056092503;15423.691526169414;15580.532584022498;912.4023764434173;935.4060171790961;947.0482165423705;950.3727539823683;970.8009857979098;8883.911160888309;9303.72088837336;9315.115064068903;9438.90561094394;9544.236461083097;496203;502483;503497;505372;516372;64085.679571601846;64190;64389;66558;67076;1030.2891005206384;1037.7301901505512;1046.429695815767;1048.2662136504478;1070.480816803865;14189.858101419266;14210.118740319804;14380.209088499814;14516.782248266074;14584.124952502883;30594;30703.539446908762;31406.685933140376;31625.051248462583;32440.675593243766;39918;39919.2016159681;40390.79804600958;40807.795961020005;41388.586114138474;6958.965205173941;7219.241979592067;7222.169450513258;7257.092863392076;7324.523905946096;8458;10422.478876056015;10578.15374770032;10824.4046577439;10901.182411319025;8060.31487323584;9140.223081038186;9261.351705380559;9521.95239023828;9614.759631009281;2963.5406511990677;2980.389020250887;9610.002798544858;9644.614215431304;9661.13049825519;8307.210814972568;9257.305702072506;9600.279979001743;9793.902060979299;9814.950925245328;6998.125234345707;7304.050473438419;7305.5981920994855;7328.816779580553;7342.192358840416;8752.868706969528;9076.183143517115;9416.10546998034;9800.362976406795;9853.310268281151 07:25:45 INFO - PROCESS | 29628 | |3;mootools.html;1458.2490017640914;1474.262868565717;1614.8385161483852;1762.3567397899753;1762.6122253104313;7220.4945653804125;7421.888671669929;7463.925360746391;7604.961975190124;7621.161672216059;7683.423743219253;7753.379729621631;7806.258405451473;7830.138684744674;7859.56772377519;2292.793648571628;2296.9310920672365;2302.769723027692;2303.2399308228246;2315.120254303371;2335.6496525521225;2343.414146463384;2369.680093187415;2370.5732968065827;2376.7504412036747;2229.442639340165;2262.9773702262933;2276.0440614941763;2284.326123793485;2294.529621427612;2273.6703178039174;2279.4643258834326;2283.109587260978;2289.347535952254;2296.7473577906417;2311.167979527386;2338.590746619335;2338.847974881627;2343.6250199968094;2352.4706940938154;7578.280063393969;7585.317321441042;7594.278543538355;7615.35269502093;7616.657250423744;4699.036697477043;4810.374651295344;4832.710037397732;4837.1776797944085;4840.467548569654;2960.970390296091;2967.55486676998;2997.070908018521;3021.6676165621766;3024.228821650487;931.2643012020495;956.1776871890169;966.2849491376401;988.9208863290919;994.3089552760835;10269.486525673761;10295.742606434898;10358.63744768937;10411.53148108337;10413.843792343121;4228.534861165269;4230.915381692349;4235.767032813224;4252.277112890816;4379.386885835986;8898.332625053146;8931.106889311146;8958.10418958099;8961.507117108622;9043.728688139367;4791.233402655628;4805.471398146201;4827.589654879374;4852.539008794159;4864.22172452413;4331.025519258142;4341.956580434218;4381.824727010884;4410.272305069628;4412.294032954712;3578.7137029037613;3597.94603080954;3607.0801945503727;3619.7104231661406;3634.636536346344;1163.2206421697483;1167.6847251242286;1170.8302296167178;1183.5147589488267;1186.483879512415;956.7082039977735;959.3380567408466;1049.2812423489934;1084.4415126210008;1245.819356193347;6980;6981.05755722981;7007.964960175166;7021.824454388681;7034.50758446914;1092.874319453273;1108.4623957380663;1113.6102364172475;1114.420501339299;1138.5559631743627;5493.176023596413;5493.697846618395;5513.173024046425;5519.889602207933;5552.250446189793;8861.424007439497;8918.10818918103;9296.116868897443;9316.114969078062;9442.197413219816;9210.493422861808;9226.40028398152;9232.815343693088;9294.209992150743;9353.345265831462;6898.482613803984;7116.430685545144;7159.105111861018;7175.533590316612;7219.314165154302;7023.929760702532;7059.082319298458;7085.929140708527;7102.786916392516;7134.60759658203;7995.9200407997505;8334.333253339839;8351.373646976623;8370.372222083246;8489.10864359258;8379.120192379956;8682.088380719933;8749.212570868653;8750.47497150173;8782.780430489034;7181.245969173162;7308.378787803096;7321.267873212849;7326.9267307326245;7343.485955983244;7416.888746668912;7421.777346679608;7422.035135432359;7430.108386993596;7512.586807725627;6969.930300697131;7047.823804404931;7154.964225178841;7277.417806575567;7297.087864016998;6054.212952316171;6408;6660.234073081658;6681.265060843206;6762.256151823394;6891.75878844238;6920.134983127109;6921.169459664872;6941.47938904574;6948.096747422803;6243.968780156252;6249.9062514063235;6264.21697287839;6265.74937002533;6282.528810339151;6137.3862613738265;6171.197744293213;6195.473384762346;6196.690165491617;6207.906881396873 07:25:45 INFO - PROCESS | 29628 | |4;prototype.html;315.6007650322343;328.7205875006245;335.414701346151;338.36387591328315;339.4822895084995;6283.905741413871;6297;6368.04479328101;6383.074454204143;6406.775762848301;6232.3144454110125;6348.841278968017;6355.71399287032;6377.713002914868;6383.106365108889;4744.0511897620445;4748.5014073522125;4759.595434388081;4763.214069678516;4763.285507173917;4763.975745214778;4764.380630518028;4765.166095933215;4771.5467030632035;4773.80904763809;4642.558956899089;4705.458872229703;4715.457722361921;4716.811327546911;4730;4654.4647365553055;4706.623470122399;4709.340692303081;4713.575778179946;4717.575418212377;4018.7789671568053;4070.0638853063665;4072.572379900127;4079.653229475498;4092.508898932147;5962.195103661037;5966.552508561876;5983.581149319506;5999.550033747443;6004.78983235589;5369.40936496985;5501.119820828648;5508.283923089973;5512.5589952803675;5529.142982837667;6631.568948018364;6672.366125218096;6674.16572928384;6681.298463661343;6710.060591517192;4506.616937560311;4523.909521809545;4530.29780384041;4534.455865296186;4541.137183935075;6807.183138023419;6879.208890977501;6915.239323674392;6918.273581273995;6985.511014229006;4617.191991401492;4620.099080679235;4621.4223222097235;4622.352870598119;4641.466231383367;4677.789499472532;4679.298105284167;4694.7887345068875;4695.506971767915;4700.341952126705;5462.754176062087;5473.534749546254;5476.616636835463;5484.287042684426;5488.615796894179;6544.363998079803;6549.574277671936;6629.635370054597;6639.70121344531;6700.095487109178;1566.091666833234;1569.1448160752418;1570.3090640118312;1574.6063484128968;1642.24456749894;1083.3012706804068;1087.5812812067252;1092.257265059751;1098.0172745392988;1098.2751384086464;6237.594556353823;6247.2815626202655;6291.402316779899;6293.779717709858;6335.68321583919;6754.189497260262;6792.117024786845;6804.285550017177;6805.523613347018;6821.658917054127;6091.116788065706;6175;6220.440160385587;6228.159198508143;6268.780592679234;3676.117731744362;3692.538432695913;3696.260747850387;3703.0187000444903;3703.7962912039557;7084.752033678797;7088.716451341992;7096.53872498286;7101.218865924744;7107.609081500567;6718.66406679664;6939.410150137194;6948.166220053525;6953.165620125516;6970.198427180838;7056.7530136444975;7091.376190809434;7102.538335008311;7126.394256488153;7146.428285737024;6797;6799.524033317621;6877.3810357068105;6917.515773895779;6930.965345173444;6604.570702904296;6672.299408562031;6679.666016699242;6708.966455167888;6745.52781305304;7045.225025247116;7089.220185779457;7115.5730656160795;7115.608641524559;7117.359437650636;4627.375304333872;4630.814767409266;4632.4904260531985;4637.25803871379;4644.651651126247;6698.83252918681;6705.329467053256;6792.117024786746;6795.082663840516;6928.965355173192;6747.763828265987;6816.420604248694;6818.386345228953;6833.4191593715095;6847.760328388483;6674.733010679518;6708.060871477899;6734.225564060196;6734.56225345351;6755.324467553205;6396.552241343062;6581.473482121514;6608.570442921195;6609.074729537965;6617.172853393326;6724.4284235840505;6761.966190169018;6765.526413151032;6781.830454238683;6788.864222715617;6568;6611.702473388806;6621.073049772939;6625.238097618835;6632.104665870046 07:25:45 INFO - PROCESS | 29628 | |5;yui.html;811.2374368093991;815.229608020421;816.5335614190378;821.2075347289866;848.991510084899;12852.485900563977;12895.806562901553;12996.675083122927;13019.958403327722;13031.869681303184;10934.289271197367;12302.261864288126;12338.753224935495;12403.689907752288;12405.317707526105;635.2821311917538;779.8128449172215;795.6817273090782;796.9203079692013;797.7965618767206;791.0230864881867;792.9524228546277;796.2674339607546;798.3533337996241;801.0587559617455;834.845553572588;835.9289460395873;838.325148255654;838.8448137094626;841.0538144587339;822.4571782623469;826.557791581501;828.7348048624442;830.667732906836;832.2883934236202;604.4499505450019;606.2785285510229;609.7652403824516;610.1061944251649;614.6588643302965;12303.753924921451;12330.568430104993;12429.627111186679;12436.937815310866;12448.75102497954;13029.478820847155;13075.86924130756;13076.803847942194;13294.401751921187;13373.264470454122;10422.270441069128;10503.789924201474;10527;10617.309874858187;10633.202509811796;3485.930281394383;3488.4244099723514;3524.1542029912894;3629.4192929131214;3648.3980143276326;48003.5199648006;48017.75991120057;48335.274970875114;48342.75828620869;49623.2556511649;9565.665201717906;9964.551595178234;10016.54925528353;10041.246906481896;10155.997312964973;17408.47774566765;17412.651746964988;17444.127793610267;17449.825501745076;17490.91254543719;7240.239774823673;7402.629868506553;7489.513181643176;7594.734184303523;7599.392048636096;4277.443932288783;4432.955670443319;4456.821727130943;4604.263317869125;4616.28447590624;2905.709429057077;2974.1523665755158;2975.0777259049764;2976.5535169724712;2976.583278341034;527.0276340152412;528.9365276166884;542.5252903709254;544.2842661899668;545.0951420641716;594.2482759309477;596.8239369386041;621.7761605821901;645.9160309159779;652.4128284543948;8166.438858184188;8213.589320534069;8273.627686754111;8424.53665048416;8430.704925327584;521.7625980179009;531.5110098709197;570.6661602962314;632.4150161100963;640.9776406631415;3992.3612222044335;4160.396742472324;4224.5353011168745;4276.893077673083;4277.871663850089;56740.71629641826;57008;57151.42848571544;57216;57315.14027289594;52924.206136907975;53352.733236333566;53685;53778.193327100125;54641.726791365785;45716.771416142044;45886.12167016212;46147;46358.30462543065;46436;9014.954925225333;9050.185483306534;9381.343305968516;9453.858192126985;9481.620735170516;33719.49420758642;33752.32495350128;33879.66120338765;34006;34319;41668.37497437601;41900.1619967605;43147;44353.55646443494;44536;11320;11348.262362946381;11376.431178441211;11422.57217847769;11444.313341199555;12201.14591978553;12476.750464990831;12686.11197216186;12824.86016159105;13229.536966206137;10904.836427453753;10956.671299861016;11087.778244434905;11289.37908415045;11694;11410.372429516456;11843.940780296043;12016.819747703967;12027;12294.569690060805;11461.942690286494;11553.711157221136;11565.537378505102;11715;11970.640880773592;9586.952065239908;9858.408495490294;9858.698631843725;9965.202783777426;10153.39079655223;9322.533873306444;9661;9753.60985560598;9894.257930655374;10393.480325983519 07:25:45 INFO - PROCESS | 29628 | __end_tp_report 07:25:45 INFO - PROCESS | 29628 | __start_cc_report 07:25:45 INFO - PROCESS | 29628 | _x_x_mozilla_cycle_collect,320 07:25:45 INFO - PROCESS | 29628 | __end_cc_report 07:25:45 INFO - PROCESS | 29628 | __startTimestamp1453217145429__endTimestamp 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | ------- Summary: start ------- 07:25:45 INFO - PROCESS | 29628 | Number of tests: 6 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#0] dojo.html Cycles:165 Average:5181.06 Median:5412.11 stddev:565.35 (10.4%) stddev-sans-first:542.54 07:25:45 INFO - PROCESS | 29628 | Values: 3080.4 3097.8 3130.7 3131.6 3146.2 4923.6 5171.3 5182.0 5185.0 5237.7 5102.3 5262.8 5267.1 5276.9 5298.6 4680.1 4717.9 4830.3 4830.4 4850.2 4640.0 4763.7 4813.2 4819.7 4857.7 4622.0 4630.4 4644.7 4742.1 4784.9 4779.4 4784.4 4785.5 4809.0 4822.4 4662.9 4712.9 4725.9 4738.8 4762.3 4952.3 5019.3 5070.0 5126.9 5211.3 5560.5 5572.7 5574.8 5576.8 5596.3 5505.4 5646.9 5651.2 5653.6 5707.9 5141.6 5186.6 5191.8 5265.0 5275.9 5686.5 5692.9 5699.0 5699.3 5719.5 5357.9 5433.8 5450.2 5493.4 5531.5 5434.0 5541.5 5591.9 5604.0 5663.6 5527.6 5533.3 5549.0 5549.6 5551.1 5444.5 5500.9 5521.7 5534.1 5615.7 4374.6 4408.3 4414.3 4428.8 4441.0 3837.4 3852.8 3863.4 3865.9 3933.6 5065.9 5142.6 5194.5 5214.2 5277.9 5615.7 5631.6 5639.6 5657.5 5665.7 5201.4 5249.9 5253.5 5271.9 5313.5 4685.3 4761.8 4764.9 4772.9 4842.2 5745.9 5836.6 5844.9 5855.3 5874.8 5490.9 5524.3 5537.7 5555.2 5579.1 5414.6 5442.3 5719.0 5727.3 5779.7 5447.2 5501.5 5509.9 5519.9 5555.6 5553.8 5609.6 5616.9 5625.0 5637.2 5347.1 5351.1 5427.6 5469.6 5523.5 5427.4 5481.7 5488.0 5498.9 5519.4 5394.0 5400.1 5412.9 5413.8 5463.8 5305.0 5412.1 5417.6 5513.2 5516.8 5403.2 5443.1 5449.8 5456.2 5473.5 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#1] ext.html Cycles:180 Average:57044.72 Median:38504.02 stddev:131541.95 (341.6%) stddev-sans-first:131842.53 07:25:45 INFO - PROCESS | 29628 | Values: 531.2 534.2 537.0 551.5 575.1 34796.1 35443.1 35655.5 35771.1 35840.0 38328.4 38785.0 39000.4 39020.0 39070.0 8436.3 8542.5 8591.4 8639.4 8644.6 8341.6 8447.1 8549.2 8617.4 8706.7 8504.8 8660.1 8704.4 8719.8 8731.4 8561.1 8677.7 8697.3 8705.4 8711.5 7485.0 8596.2 8631.1 8674.5 8683.8 38914.8 38931.8 39275.4 39515.8 39556.8 2974.8 3163.4 3187.1 3340.9 3963.7 28566.1 29196.4 29372.3 29576.3 30370.1 3686.2 3827.7 3885.9 3920.6 3933.5 263582.0 263736.0 263756.0 264216.0 265273.0 40919.4 41445.8 56860.0 57231.1 57249.0 42183.0 42455.4 42698.4 42701.4 42849.8 12871.8 12990.9 13005.3 13067.0 13081.1 9938.9 9949.7 9989.0 10034.1 10061.8 14063.4 14071.7 14093.5 14123.9 14214.0 5623.6 5659.7 5739.1 5793.2 5828.9 914.2 932.0 947.9 1024.4 1072.0 27928.7 27966.6 28074.3 28093.8 28493.7 1027.8 1058.0 1113.2 1120.4 1161.8 14432.6 14722.7 14772.6 14844.9 14889.7 726441.0 742628.0 746535.0 749226.0 750502.0 52941.2 52974.0 53247.5 53412.5 53471.7 1306.8 1308.1 1312.9 1317.7 1321.6 28820.0 29594.7 29698.6 30176.2 30404.8 45151.5 45165.1 45564.8 45750.5 45771.0 296507.0 296574.0 297547.0 297989.0 299361.0 32199.4 42581.6 43262.4 43510.3 43587.3 37904.0 38483.6 38524.4 38533.6 39053.8 32511.7 33209.5 33314.0 33484.0 33702.7 33111.0 38474.6 39759.8 40097.0 43179.1 34961.8 35655.6 35739.3 35769.8 36153.0 30662.4 32357.0 32417.7 33088.7 33110.0 24225.8 24689.0 24720.1 25040.1 25147.5 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#2] jquery.html Cycles:180 Average:25805.83 Median:255240.41 stddev:82427.36 (32.3%) stddev-sans-first:82636.45 07:25:45 INFO - PROCESS | 29628 | Values: 363.1 366.0 367.6 368.0 371.7 15696.8 16234.2 16479.3 17002.0 17361.8 15088.1 15118.1 15182.8 16115.4 16201.0 4812.6 5003.6 5004.8 5007.5 5026.2 4258.7 4907.6 4941.3 4994.6 5425.6 5014.8 5159.6 5178.9 5405.3 5431.2 5013.4 5108.8 5133.8 5166.5 5273.2 5128.7 5136.4 5139.4 5139.9 5143.3 11790.4 19138.0 19642.0 19691.9 19915.3 2004.4 2146.2 2159.3 2224.9 2265.8 8994.7 9168.7 9186.6 9212.8 9257.8 1759.6 1764.2 1773.7 1799.6 1837.8 52947.7 53798.7 54678.7 55474.4 55488.0 9404.2 9515.5 9859.2 9910.0 9936.5 12757.6 12772.6 12774.2 12791.7 12889.4 6865.8 6883.8 6891.1 6926.6 6956.6 6477.3 6479.7 6513.7 6520.5 6521.1 4225.0 4304.6 4371.8 4476.0 4524.5 1799.7 1839.2 1842.7 1855.9 1902.8 842.4 877.8 942.9 947.3 972.1 15295.4 15319.3 15354.3 15423.7 15580.5 912.4 935.4 947.0 950.4 970.8 8883.9 9303.7 9315.1 9438.9 9544.2 496203.0 502483.0 503497.0 505372.0 516372.0 64085.7 64190.0 64389.0 66558.0 67076.0 1030.3 1037.7 1046.4 1048.3 1070.5 14189.9 14210.1 14380.2 14516.8 14584.1 30594.0 30703.5 31406.7 31625.1 32440.7 39918.0 39919.2 40390.8 40807.8 41388.6 6959.0 7219.2 7222.2 7257.1 7324.5 8458.0 10422.5 10578.2 10824.4 10901.2 8060.3 9140.2 9261.4 9522.0 9614.8 2963.5 2980.4 9610.0 9644.6 9661.1 8307.2 9257.3 9600.3 9793.9 9815.0 6998.1 7304.1 7305.6 7328.8 7342.2 8752.9 9076.2 9416.1 9800.4 9853.3 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#3] mootools.html Cycles:180 Average:5400.12 Median:6257.06 stddev:2763.45 (44.2%) stddev-sans-first:2755.32 07:25:45 INFO - PROCESS | 29628 | Values: 1458.2 1474.3 1614.8 1762.4 1762.6 7220.5 7421.9 7463.9 7605.0 7621.2 7683.4 7753.4 7806.3 7830.1 7859.6 2292.8 2296.9 2302.8 2303.2 2315.1 2335.6 2343.4 2369.7 2370.6 2376.8 2229.4 2263.0 2276.0 2284.3 2294.5 2273.7 2279.5 2283.1 2289.3 2296.7 2311.2 2338.6 2338.8 2343.6 2352.5 7578.3 7585.3 7594.3 7615.4 7616.7 4699.0 4810.4 4832.7 4837.2 4840.5 2961.0 2967.6 2997.1 3021.7 3024.2 931.3 956.2 966.3 988.9 994.3 10269.5 10295.7 10358.6 10411.5 10413.8 4228.5 4230.9 4235.8 4252.3 4379.4 8898.3 8931.1 8958.1 8961.5 9043.7 4791.2 4805.5 4827.6 4852.5 4864.2 4331.0 4342.0 4381.8 4410.3 4412.3 3578.7 3597.9 3607.1 3619.7 3634.6 1163.2 1167.7 1170.8 1183.5 1186.5 956.7 959.3 1049.3 1084.4 1245.8 6980.0 6981.1 7008.0 7021.8 7034.5 1092.9 1108.5 1113.6 1114.4 1138.6 5493.2 5493.7 5513.2 5519.9 5552.3 8861.4 8918.1 9296.1 9316.1 9442.2 9210.5 9226.4 9232.8 9294.2 9353.3 6898.5 7116.4 7159.1 7175.5 7219.3 7023.9 7059.1 7085.9 7102.8 7134.6 7995.9 8334.3 8351.4 8370.4 8489.1 8379.1 8682.1 8749.2 8750.5 8782.8 7181.2 7308.4 7321.3 7326.9 7343.5 7416.9 7421.8 7422.0 7430.1 7512.6 6969.9 7047.8 7155.0 7277.4 7297.1 6054.2 6408.0 6660.2 6681.3 6762.3 6891.8 6920.1 6921.2 6941.5 6948.1 6244.0 6249.9 6264.2 6265.7 6282.5 6137.4 6171.2 6195.5 6196.7 6207.9 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#4] prototype.html Cycles:180 Average:5535.28 Median:6295.39 stddev:1696.49 (26.9%) stddev-sans-first:1655.39 07:25:45 INFO - PROCESS | 29628 | Values: 315.6 328.7 335.4 338.4 339.5 6283.9 6297.0 6368.0 6383.1 6406.8 6232.3 6348.8 6355.7 6377.7 6383.1 4744.1 4748.5 4759.6 4763.2 4763.3 4764.0 4764.4 4765.2 4771.5 4773.8 4642.6 4705.5 4715.5 4716.8 4730.0 4654.5 4706.6 4709.3 4713.6 4717.6 4018.8 4070.1 4072.6 4079.7 4092.5 5962.2 5966.6 5983.6 5999.6 6004.8 5369.4 5501.1 5508.3 5512.6 5529.1 6631.6 6672.4 6674.2 6681.3 6710.1 4506.6 4523.9 4530.3 4534.5 4541.1 6807.2 6879.2 6915.2 6918.3 6985.5 4617.2 4620.1 4621.4 4622.4 4641.5 4677.8 4679.3 4694.8 4695.5 4700.3 5462.8 5473.5 5476.6 5484.3 5488.6 6544.4 6549.6 6629.6 6639.7 6700.1 1566.1 1569.1 1570.3 1574.6 1642.2 1083.3 1087.6 1092.3 1098.0 1098.3 6237.6 6247.3 6291.4 6293.8 6335.7 6754.2 6792.1 6804.3 6805.5 6821.7 6091.1 6175.0 6220.4 6228.2 6268.8 3676.1 3692.5 3696.3 3703.0 3703.8 7084.8 7088.7 7096.5 7101.2 7107.6 6718.7 6939.4 6948.2 6953.2 6970.2 7056.8 7091.4 7102.5 7126.4 7146.4 6797.0 6799.5 6877.4 6917.5 6931.0 6604.6 6672.3 6679.7 6709.0 6745.5 7045.2 7089.2 7115.6 7115.6 7117.4 4627.4 4630.8 4632.5 4637.3 4644.7 6698.8 6705.3 6792.1 6795.1 6929.0 6747.8 6816.4 6818.4 6833.4 6847.8 6674.7 6708.1 6734.2 6734.6 6755.3 6396.6 6581.5 6608.6 6609.1 6617.2 6724.4 6762.0 6765.5 6781.8 6788.9 6568.0 6611.7 6621.1 6625.2 6632.1 07:25:45 INFO - PROCESS | 29628 | 07:25:45 INFO - PROCESS | 29628 | [#5] yui.html Cycles:180 Average:13779.20 Median:25375.63 stddev:15952.59 (62.9%) stddev-sans-first:15967.61 07:25:45 INFO - PROCESS | 29628 | Values: 811.2 815.2 816.5 821.2 849.0 12852.5 12895.8 12996.7 13020.0 13031.9 10934.3 12302.3 12338.8 12403.7 12405.3 635.3 779.8 795.7 796.9 797.8 791.0 793.0 796.3 798.4 801.1 834.8 835.9 838.3 838.8 841.1 822.5 826.6 828.7 830.7 832.3 604.4 606.3 609.8 610.1 614.7 12303.8 12330.6 12429.6 12436.9 12448.8 13029.5 13075.9 13076.8 13294.4 13373.3 10422.3 10503.8 10527.0 10617.3 10633.2 3485.9 3488.4 3524.2 3629.4 3648.4 48003.5 48017.8 48335.3 48342.8 49623.3 9565.7 9964.6 10016.5 10041.2 10156.0 17408.5 17412.7 17444.1 17449.8 17490.9 7240.2 7402.6 7489.5 7594.7 7599.4 4277.4 4433.0 4456.8 4604.3 4616.3 2905.7 2974.2 2975.1 2976.6 2976.6 527.0 528.9 542.5 544.3 545.1 594.2 596.8 621.8 645.9 652.4 8166.4 8213.6 8273.6 8424.5 8430.7 521.8 531.5 570.7 632.4 641.0 3992.4 4160.4 4224.5 4276.9 4277.9 56740.7 57008.0 57151.4 57216.0 57315.1 52924.2 53352.7 53685.0 53778.2 54641.7 45716.8 45886.1 46147.0 46358.3 46436.0 9015.0 9050.2 9381.3 9453.9 9481.6 33719.5 33752.3 33879.7 34006.0 34319.0 41668.4 41900.2 43147.0 44353.6 44536.0 11320.0 11348.3 11376.4 11422.6 11444.3 12201.1 12476.8 12686.1 12824.9 13229.5 10904.8 10956.7 11087.8 11289.4 11694.0 11410.4 11843.9 12016.8 12027.0 12294.6 11461.9 11553.7 11565.5 11715.0 11970.6 9587.0 9858.4 9858.7 9965.2 10153.4 9322.5 9661.0 9753.6 9894.3 10393.5 07:25:45 INFO - PROCESS | 29628 | -------- Summary: end -------- 07:25:45 INFO - PROCESS | 29628 | 07:25:46 INFO - TEST-INFO | 29628: exit 0 07:25:46 INFO - TEST-OK | dromaeo_css | took 1110647ms 07:25:46 INFO - TEST-START | kraken 07:25:46 INFO - operating with platform_type : linux_ 07:25:46 INFO - Initialising browser for kraken test... 07:25:46 INFO - TEST-INFO | started process 29876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUGQxxh/profile http://localhost:59159/getInfo.html) 07:25:49 INFO - PROCESS | 29876 | 07:25:49 INFO - PROCESS | 29876 | (process:29947): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:25:50 INFO - PROCESS | 29876 | __metrics Screen width/height:1600/1200 07:25:50 INFO - PROCESS | 29876 | colorDepth:24 07:25:50 INFO - PROCESS | 29876 | Browser inner width/height: 1024/697 07:25:50 INFO - PROCESS | 29876 | __metrics 07:25:50 INFO - PROCESS | 29876 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:25:51 INFO - TEST-INFO | 29876: exit 0 07:25:51 INFO - Browser initialized. 07:25:51 INFO - Running cycle 1/1 for kraken test... 07:25:51 INFO - TEST-INFO | started process 29996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUGQxxh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:52 INFO - PROCESS | 29996 | -- checkerboarding starts below -- 07:25:52 INFO - PROCESS | 29996 | RENDERTRACE 0.047794 rect red 0 0 10 10 // viewport 07:25:52 INFO - PROCESS | 29996 | RENDERTRACE 36.6971 rect brown 0 0 10 10 // page 07:25:52 INFO - PROCESS | 29996 | RENDERTRACE 36.7193 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 07:25:52 INFO - PROCESS | 29996 | Checkerboarded for 1 frames (50.3278 ms), 100 peak, 1 severity. 07:25:53 INFO - PROCESS | 29996 | 07:25:53 INFO - PROCESS | 29996 | (process:30056): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:03 INFO - PROCESS | 29996 | RSS: Main: 149594112 07:26:03 INFO - PROCESS | 29996 | 07:26:06 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:06 INFO - PROCESS | 29996 | RSS: Main: 149798912 07:26:06 INFO - PROCESS | 29996 | 07:26:09 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-dft) 07:26:10 INFO - PROCESS | 29996 | RSS: Main: 153325568 07:26:10 INFO - PROCESS | 29996 | 07:26:12 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-fft) 07:26:13 INFO - PROCESS | 29996 | RSS: Main: 148033536 07:26:13 INFO - PROCESS | 29996 | 07:26:15 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator) 07:26:16 INFO - PROCESS | 29996 | RSS: Main: 148463616 07:26:16 INFO - PROCESS | 29996 | 07:26:18 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:19 INFO - PROCESS | 29996 | RSS: Main: 148041728 07:26:19 INFO - PROCESS | 29996 | 07:26:22 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:22 INFO - PROCESS | 29996 | RSS: Main: 148492288 07:26:22 INFO - PROCESS | 29996 | 07:26:26 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:26 INFO - PROCESS | 29996 | RSS: Main: 148979712 07:26:26 INFO - PROCESS | 29996 | 07:26:29 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial) 07:26:30 INFO - PROCESS | 29996 | RSS: Main: 148733952 07:26:30 INFO - PROCESS | 29996 | 07:26:31 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:32 INFO - PROCESS | 29996 | RSS: Main: 148107264 07:26:32 INFO - PROCESS | 29996 | 07:26:34 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:34 INFO - PROCESS | 29996 | RSS: Main: 148426752 07:26:34 INFO - PROCESS | 29996 | 07:26:36 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:37 INFO - PROCESS | 29996 | RSS: Main: 148828160 07:26:37 INFO - PROCESS | 29996 | 07:26:39 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:40 INFO - PROCESS | 29996 | RSS: Main: 149655552 07:26:40 INFO - PROCESS | 29996 | 07:26:43 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:43 INFO - PROCESS | 29996 | RSS: Main: 149168128 07:26:43 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | Cycle 1(1): loaded http://localhost:59159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59159/tests/kraken/driver.html?testName=ai-astar) 07:26:45 INFO - PROCESS | 29996 | RSS: Main: 149962752 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | __start_tp_report 07:26:45 INFO - PROCESS | 29996 | _x_x_mozilla_page_load 07:26:45 INFO - PROCESS | 29996 | _x_x_mozilla_page_load_details 07:26:45 INFO - PROCESS | 29996 | |i|pagename|runs| 07:26:45 INFO - PROCESS | 29996 | |0;ai-astar;113;108;113;113;112;128;113;111;113;111 07:26:45 INFO - PROCESS | 29996 | |1;audio-beat-detection;157;125;157;160;135;155;154;131;167;128 07:26:45 INFO - PROCESS | 29996 | |2;audio-dft;165;166;164;165;164;163;162;167;166;165 07:26:45 INFO - PROCESS | 29996 | |3;audio-fft;72;76;73;75;74;75;134;74;74;73 07:26:45 INFO - PROCESS | 29996 | |4;audio-oscillator;96;97;142;97;98;96;138;97;96;144 07:26:45 INFO - PROCESS | 29996 | |5;imaging-gaussian-blur;110;109;109;109;110;110;110;110;109;110 07:26:45 INFO - PROCESS | 29996 | |6;imaging-darkroom;148;147;147;148;147;146;147;147;147;147 07:26:45 INFO - PROCESS | 29996 | |7;imaging-desaturate;96;97;96;98;97;97;97;97;96;96 07:26:45 INFO - PROCESS | 29996 | |8;json-parse-financial;60;60;61;59;62;62;60;60;69;58 07:26:45 INFO - PROCESS | 29996 | |9;json-stringify-tinderbox;67;69;68;67;68;67;68;68;68;69 07:26:45 INFO - PROCESS | 29996 | |10;stanford-crypto-aes;82;82;86;84;88;84;84;83;83;84 07:26:45 INFO - PROCESS | 29996 | |11;stanford-crypto-ccm;118;117;121;116;124;116;125;128;128;119 07:26:45 INFO - PROCESS | 29996 | |12;stanford-crypto-pbkdf2;146;151;164;151;151;144;151;151;150;144 07:26:45 INFO - PROCESS | 29996 | |13;stanford-crypto-sha256-iterative;67;70;71;68;73;70;67;70;70;67 07:26:45 INFO - PROCESS | 29996 | __end_tp_report 07:26:45 INFO - PROCESS | 29996 | __start_cc_report 07:26:45 INFO - PROCESS | 29996 | _x_x_mozilla_cycle_collect,747 07:26:45 INFO - PROCESS | 29996 | __end_cc_report 07:26:45 INFO - PROCESS | 29996 | __startTimestamp1453217205651__endTimestamp 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | ------- Summary: start ------- 07:26:45 INFO - PROCESS | 29996 | Number of tests: 14 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:5.34 (4.7%) stddev-sans-first:5.66 07:26:45 INFO - PROCESS | 29996 | Values: 113.0 108.0 113.0 113.0 112.0 128.0 113.0 111.0 113.0 111.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:156.00 stddev:15.37 (9.9%) stddev-sans-first:15.86 07:26:45 INFO - PROCESS | 29996 | Values: 157.0 125.0 157.0 160.0 135.0 155.0 154.0 131.0 167.0 128.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 07:26:45 INFO - PROCESS | 29996 | Values: 165.0 166.0 164.0 165.0 164.0 163.0 162.0 167.0 166.0 165.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:19.01 (25.7%) stddev-sans-first:19.94 07:26:45 INFO - PROCESS | 29996 | Values: 72.0 76.0 73.0 75.0 74.0 75.0 134.0 74.0 74.0 73.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.50 stddev:21.61 (22.4%) stddev-sans-first:22.31 07:26:45 INFO - PROCESS | 29996 | Values: 96.0 97.0 142.0 97.0 98.0 96.0 138.0 97.0 96.0 144.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:26:45 INFO - PROCESS | 29996 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 07:26:45 INFO - PROCESS | 29996 | Values: 148.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 147.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 07:26:45 INFO - PROCESS | 29996 | Values: 96.0 97.0 96.0 98.0 97.0 97.0 97.0 97.0 96.0 96.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:3.03 (5.0%) stddev-sans-first:3.19 07:26:45 INFO - PROCESS | 29996 | Values: 60.0 60.0 61.0 59.0 62.0 62.0 60.0 60.0 69.0 58.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 07:26:45 INFO - PROCESS | 29996 | Values: 67.0 69.0 68.0 67.0 68.0 67.0 68.0 68.0 68.0 69.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.83 (2.2%) stddev-sans-first:1.79 07:26:45 INFO - PROCESS | 29996 | Values: 82.0 82.0 86.0 84.0 88.0 84.0 84.0 83.0 83.0 84.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.50 stddev:4.73 (3.9%) stddev-sans-first:4.88 07:26:45 INFO - PROCESS | 29996 | Values: 118.0 117.0 121.0 116.0 124.0 116.0 125.0 128.0 128.0 119.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:151.00 stddev:5.66 (3.7%) stddev-sans-first:5.78 07:26:45 INFO - PROCESS | 29996 | Values: 146.0 151.0 164.0 151.0 151.0 144.0 151.0 151.0 150.0 144.0 07:26:45 INFO - PROCESS | 29996 | 07:26:45 INFO - PROCESS | 29996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:2.00 (2.9%) stddev-sans-first:1.94 07:26:45 INFO - PROCESS | 29996 | Values: 67.0 70.0 71.0 68.0 73.0 70.0 67.0 70.0 70.0 67.0 07:26:45 INFO - PROCESS | 29996 | -------- Summary: end -------- 07:26:45 INFO - PROCESS | 29996 | 07:26:46 INFO - TEST-INFO | 29996: exit 0 07:26:46 INFO - TEST-OK | kraken | took 60453ms 07:26:46 INFO - TEST-START | v8_7 07:26:46 INFO - operating with platform_type : linux_ 07:26:46 INFO - Initialising browser for v8_7 test... 07:26:46 INFO - TEST-INFO | started process 30284 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKISgqi/profile http://localhost:59159/getInfo.html) 07:26:50 INFO - PROCESS | 30284 | 07:26:50 INFO - PROCESS | 30284 | (process:30353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:26:51 INFO - PROCESS | 30284 | __metrics Screen width/height:1600/1200 07:26:51 INFO - PROCESS | 30284 | colorDepth:24 07:26:51 INFO - PROCESS | 30284 | Browser inner width/height: 1024/697 07:26:51 INFO - PROCESS | 30284 | __metrics 07:26:51 INFO - PROCESS | 30284 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:26:52 INFO - TEST-INFO | 30284: exit 0 07:26:52 INFO - Browser initialized. 07:26:52 INFO - Running cycle 1/1 for v8_7 test... 07:26:52 INFO - TEST-INFO | started process 30402 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKISgqi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:52 INFO - PROCESS | 30402 | -- checkerboarding starts below -- 07:26:52 INFO - PROCESS | 30402 | RENDERTRACE 0.04564 rect red 0 0 10 10 // viewport 07:26:52 INFO - PROCESS | 30402 | RENDERTRACE 86.7354 rect brown 0 0 10 10 // page 07:26:52 INFO - PROCESS | 30402 | RENDERTRACE 86.7671 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 07:26:52 INFO - PROCESS | 30402 | Checkerboarded for 1 frames (100.919 ms), 100 peak, 1 severity. 07:26:53 INFO - PROCESS | 30402 | 07:26:53 INFO - PROCESS | 30402 | (process:30464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:27:04 INFO - PROCESS | 30402 | RSS: Main: 150462464 07:27:04 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | Cycle 1(1): loaded http://localhost:59159/tests/v8_7/run.html (next: http://localhost:59159/tests/v8_7/run.html) 07:27:26 INFO - PROCESS | 30402 | RSS: Main: 145195008 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | __start_tp_report 07:27:26 INFO - PROCESS | 30402 | _x_x_mozilla_page_load 07:27:26 INFO - PROCESS | 30402 | _x_x_mozilla_page_load_details 07:27:26 INFO - PROCESS | 30402 | |i|pagename|runs| 07:27:26 INFO - PROCESS | 30402 | |0;Richards;167.0843776106934 07:27:26 INFO - PROCESS | 30402 | |1;DeltaBlue;188.39487565938205 07:27:26 INFO - PROCESS | 30402 | |2;Encrypt;280.97780275358247 07:27:26 INFO - PROCESS | 30402 | |3;Decrypt;5223.958333333333 07:27:26 INFO - PROCESS | 30402 | |4;RayTrace;1082.2510822510822 07:27:26 INFO - PROCESS | 30402 | |5;Earley;723.0657989877079 07:27:26 INFO - PROCESS | 30402 | |6;Boyer;12500 07:27:26 INFO - PROCESS | 30402 | |7;RegExp;41080 07:27:26 INFO - PROCESS | 30402 | |8;Splay;633.3122229259025 07:27:26 INFO - PROCESS | 30402 | |9;NavierStokes;4830.917874396136 07:27:26 INFO - PROCESS | 30402 | __end_tp_report 07:27:26 INFO - PROCESS | 30402 | __startTimestamp1453217246718__endTimestamp 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | ------- Summary: start ------- 07:27:26 INFO - PROCESS | 30402 | Number of tests: 10 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 167.1 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 188.4 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 281.0 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 5224.0 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 1082.3 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#5] Earley Cycles:1 Average:723.07 Median:723.07 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 723.1 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 12500.0 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#7] RegExp Cycles:1 Average:41080.00 Median:41080.00 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 41080.0 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#8] Splay Cycles:1 Average:633.31 Median:633.31 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 633.3 07:27:26 INFO - PROCESS | 30402 | 07:27:26 INFO - PROCESS | 30402 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:27:26 INFO - PROCESS | 30402 | Values: 4830.9 07:27:26 INFO - PROCESS | 30402 | -------- Summary: end -------- 07:27:26 INFO - PROCESS | 30402 | 07:27:27 INFO - TEST-INFO | 30402: exit 0 07:27:27 INFO - TEST-OK | v8_7 | took 41016ms 07:27:27 INFO - SUITE-END | took 1212s 07:27:27 INFO - Completed test suite (00:20:12) 07:27:27 INFO - Working with test: dromaeo_css 07:27:27 INFO - Generating results file: dromaeo_css 07:27:27 INFO - Working with test: kraken 07:27:27 INFO - Generating results file: kraken 07:27:27 INFO - javascript benchmark 07:27:27 INFO - Working with test: v8_7 07:27:27 INFO - Generating results file: v8_7 07:27:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 07:27:27 INFO - process_Request line: dromaeo_css 6812.87 graph.html#tests=[[72,63,43]] 07:27:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:27 INFO - process_Request line: kraken 1522.40 graph.html#tests=[[232,63,43]] 07:27:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:27 INFO - process_Request line: v8_7 20168.54 graph.html#tests=[[230,63,43]] 07:27:27 INFO - RETURN: dromaeo_css: 6812.87 07:27:27 INFO - RETURN: kraken: 1522.40 07:27:27 INFO - RETURN: v8_7: 20168.54 07:27:27 INFO - javascript benchmark 07:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3080.414721202971, 3097.7918611741425, 3130.733887619552, 3131.5928929239208, 3146.1505393543744, 4923.581495572872, 5171.276021357008, 5182.0, 5184.999999999995, 5237.685738855662, 5102.285680004802, 5262.842114736564, 5267.1045922193225, 5276.9208461873, 5298.576113910887, 4680.134175177603, 4717.9292310615365, 4830.275458681208, 4830.420349558058, 4850.223964165734, 4639.976800115995, 4763.666543341968, 4813.15769740294, 4819.734914579697, 4857.73282469464, 4622.0, 4630.37489938859, 4644.744539050368, 4742.1227072991605, 4784.928226076577, 4779.378680771478, 4784.378030855966, 4785.497522760095, 4809.038192361541, 4822.445418776851, 4662.906741865144, 4712.929306060412, 4725.905481890377, 4738.763061846894, 4762.333273341735, 4952.33143525623, 5019.272205530177, 5069.974650126763, 5126.897462050738, 5211.296474975906, 5560.527355174815, 5572.693501857396, 5574.777008919638, 5576.776928922838, 5596.27248457702, 5505.394406615269, 5646.943530564683, 5651.237082993825, 5653.632513886584, 5707.942920570783, 5141.562967147797, 5186.611004174702, 5191.766370513336, 5264.973675131638, 5275.868103297372, 5686.516646085129, 5692.8861422771315, 5699.0, 5699.344575373885, 5719.48524632785, 5357.919631205535, 5433.809816656477, 5450.182472629137, 5493.423190565013, 5531.474509921551, 5434.049041417815, 5541.501264886179, 5591.8602034948635, 5603.971980140073, 5663.575231857627, 5527.55779537636, 5533.280673512418, 5549.001179787596, 5549.5837812164245, 5551.111822108443, 5444.537214336747, 5500.944990550123, 5521.723913804374, 5534.142207957773, 5615.747291371898, 4374.62815660666, 4408.338749187584, 4414.3157810539415, 4428.82284708608, 4441.0, 3837.3668344723364, 3852.768833869977, 3863.36254518007, 3865.9226815464094, 3933.6066393360434, 5065.898682026339, 5142.61430392722, 5194.506521880416, 5214.191800270964, 5277.920831187535, 5615.663060216319, 5631.605787594911, 5639.6334238274385, 5657.519110875622, 5665.716714164275, 5201.375834899836, 5249.921251181236, 5253.474652534793, 5271.894562108736, 5313.548348390353, 4685.273782563708, 4761.809527618926, 4764.928526072112, 4772.856814295576, 4842.225243960949, 5745.9425405745405, 5836.649801011953, 5844.912326315109, 5855.3266374367495, 5874.823755287348, 5490.890182196254, 5524.254225679482, 5537.723113844211, 5555.22226888244, 5579.079451890392, 5414.620976531605, 5442.319710036246, 5718.971405142947, 5727.284089488814, 5779.682117483579, 5447.210154527492, 5501.5323697486165, 5509.944900551103, 5519.862003449946, 5555.638883472561, 5553.805616803393, 5609.579281553982, 5616.943830561642, 5625.043742563692, 5637.238972738628, 5347.117725575236, 5351.090314646442, 5427.592930530305, 5469.617126801086, 5523.530499907552, 5427.375851776938, 5481.671099734029, 5487.972560137174, 5498.862528436821, 5519.39286678473, 5394.0, 5400.1089820180805, 5412.891742165213, 5413.83758487246, 5463.754131064032, 5305.018571564273, 5412.107002344569, 5417.620766546304, 5513.228148059195, 5516.779328826962, 5403.162509810985, 5443.101888188405, 5449.782008719765, 5456.236126942152, 5473.480019398151], "unit": "score", "name": "dojo.html", "value": 5145.077933956933}, {"lowerIsBetter": false, "replicates": [531.2350215689405, 534.1800336483498, 536.9677819330841, 551.5449753952988, 575.0597772641732, 34796.13009674756, 35443.1139221519, 35655.4651680225, 35771.10572235695, 35840.0, 38328.42507362385, 38785.0, 39000.41499377511, 39020.0, 39070.0, 8436.282915952135, 8542.462356775777, 8591.398602097855, 8639.352048596349, 8644.567771611426, 8341.624626891775, 8447.113053129426, 8549.230569248766, 8617.353698472609, 8706.738797836075, 8504.829903401927, 8660.090690477504, 8704.390692651517, 8719.825603487927, 8731.388802783807, 8561.0582835888, 8677.652893884237, 8697.260732837716, 8705.390622656416, 8711.477311361306, 7485.0, 8596.183362580545, 8631.093735157781, 8674.479531228146, 8683.826323473495, 38914.80542597297, 38931.8053409734, 39275.41086883699, 39515.802420987995, 39556.80221598873, 2974.803415074317, 3163.398954198695, 3187.139472342478, 3340.9391256143626, 3963.7027222958395, 28566.143015709564, 29196.41607167866, 29372.265693357836, 29576.26059348512, 30370.088897333117, 3686.2430164136044, 3827.655511004023, 3885.9028524286837, 3920.6275403836876, 3933.4886464759684, 263582.0, 263736.0, 263756.0, 264216.0, 265273.0, 40919.38620920689, 41445.79277103595, 56860.0, 57231.14153287704, 57249.0, 42183.0, 42455.36316955248, 42698.359524607156, 42701.35947960783, 42849.785751071046, 12871.806922896165, 12990.935045324903, 13005.284709340887, 13067.0, 13081.084324097412, 9938.900610993798, 9949.651762188289, 9989.0, 10034.147097496794, 10061.798764024825, 14063.367148478139, 14071.71856562863, 14093.506727264497, 14123.858761412459, 14214.0, 5623.578231632562, 5659.660420374791, 5739.053056245756, 5793.217915581343, 5828.88342233153, 914.1635403605626, 932.0, 947.8767760191131, 1024.4314405504867, 1071.9709079283818, 27928.72071279302, 27966.580501292498, 28074.29814254619, 28093.752499799968, 28493.715062849522, 1027.7995790820867, 1057.9896199129812, 1113.2263077161458, 1120.3781901045, 1161.7560312334504, 14432.639184020483, 14722.705545889237, 14772.556823295103, 14844.851551484348, 14889.702205956037, 726441.0, 742628.0, 746535.0, 749226.0, 750502.0, 52941.20588191103, 52974.0, 53247.46752532425, 53412.46587534153, 53471.732641336544, 1306.7713150198676, 1308.149702693238, 1312.9277889715966, 1317.6639956810952, 1321.6101250131235, 28820.0, 29594.704052959194, 29698.55452168176, 30176.24559386033, 30404.847975759978, 45151.548484516046, 45165.09669806651, 45564.772176138904, 45750.54249457463, 45771.0, 296507.0, 296574.0, 297547.0, 297989.0, 299361.0, 32199.356012879143, 42581.57418425776, 43262.351064733426, 43510.34734478922, 43587.34618980654, 37904.0, 38483.61516384912, 38524.42213366858, 38533.614663853004, 39053.80473097616, 32511.674883250864, 33209.50185747264, 33314.0, 33484.0, 33702.66297336995, 33111.0, 38474.61525384822, 39759.80120099381, 40097.0, 43179.13641727211, 34961.8251908749, 35655.64344356627, 35739.28521429609, 35769.82115089408, 36153.0, 30662.386752265276, 32357.029289121365, 32417.675823241465, 33088.67645294161, 33110.0, 24225.75774242235, 24689.0, 24720.13479528208, 25040.123595674064, 25147.49705005926], "unit": "score", "name": "ext.html", "value": 18040.238797621027}, {"lowerIsBetter": false, "replicates": [363.1375483227333, 365.9652333028363, 367.5956447907302, 367.9595244523103, 371.6970668904844, 15696.764548531766, 16234.188290585482, 16479.258433370498, 17002.0, 17361.82638173618, 15088.094714317122, 15118.092914425115, 15182.772258416133, 16115.435959741382, 16201.0, 4812.6390520711, 5003.574696150831, 5004.849854504352, 5007.474215207405, 5026.170681837492, 4258.659307255412, 4907.6073914086965, 4941.258811178334, 4994.550490455877, 5425.6202065855405, 5014.774335154909, 5159.5614372778355, 5178.948210517884, 5405.270288511059, 5431.158170483582, 5013.373328333958, 5108.8211912583065, 5133.844884900905, 5166.535011848933, 5273.182656688219, 5128.71792051437, 5136.383633963948, 5139.383274007106, 5139.897202055975, 5143.3313669223135, 11790.410479475991, 19138.0, 19642.017899104987, 19691.90154049235, 19915.302964396178, 2004.3586052463218, 2146.152269853415, 2159.255057005331, 2224.877631730254, 2265.784750448705, 8994.685186018458, 9168.724938251797, 9186.63253469867, 9212.769680757967, 9257.814843703156, 1759.5864971731633, 1764.1708397053364, 1773.733939909011, 1799.595091104504, 1837.7610910581673, 52947.73526132383, 53798.73100634511, 54678.72660636671, 55474.44525554733, 55488.0, 9404.200642945427, 9515.476648784244, 9859.211263098934, 9910.0, 9936.453495057696, 12757.617271481871, 12772.552960646333, 12774.169678970837, 12791.744165116646, 12889.419976101099, 6865.828354291183, 6883.7590684325805, 6891.138607674041, 6926.61903595297, 6956.582605043714, 6477.255115661665, 6479.740810367627, 6513.674316284261, 6520.510961677893, 6521.11964884744, 4224.957750422518, 4304.569543045671, 4371.78141092944, 4475.955240447619, 4524.524924882906, 1799.6850551153757, 1839.2343350383514, 1842.6959551674092, 1855.9072046397896, 1902.8192321729414, 842.4315276025467, 877.7630039889322, 942.9009953954874, 947.251671179774, 972.0716715536787, 15295.388184472497, 15319.31063102163, 15354.309056092503, 15423.691526169414, 15580.532584022498, 912.4023764434173, 935.4060171790961, 947.0482165423705, 950.3727539823683, 970.8009857979098, 8883.911160888309, 9303.72088837336, 9315.115064068903, 9438.90561094394, 9544.236461083097, 496203.0, 502483.0, 503497.0, 505372.0, 516372.0, 64085.679571601846, 64190.0, 64389.0, 66558.0, 67076.0, 1030.2891005206384, 1037.7301901505512, 1046.429695815767, 1048.2662136504478, 1070.480816803865, 14189.858101419266, 14210.118740319804, 14380.209088499814, 14516.782248266074, 14584.124952502883, 30594.0, 30703.539446908762, 31406.685933140376, 31625.051248462583, 32440.675593243766, 39918.0, 39919.2016159681, 40390.79804600958, 40807.795961020005, 41388.586114138474, 6958.965205173941, 7219.241979592067, 7222.169450513258, 7257.092863392076, 7324.523905946096, 8458.0, 10422.478876056015, 10578.15374770032, 10824.4046577439, 10901.182411319025, 8060.31487323584, 9140.223081038186, 9261.351705380559, 9521.95239023828, 9614.759631009281, 2963.5406511990677, 2980.389020250887, 9610.002798544858, 9644.614215431304, 9661.13049825519, 8307.210814972568, 9257.305702072506, 9600.279979001743, 9793.902060979299, 9814.950925245328, 6998.125234345707, 7304.050473438419, 7305.5981920994855, 7328.816779580553, 7342.192358840416, 8752.868706969528, 9076.183143517115, 9416.10546998034, 9800.362976406795, 9853.310268281151], "unit": "score", "name": "jquery.html", "value": 7776.451636375942}, {"lowerIsBetter": false, "replicates": [1458.2490017640914, 1474.262868565717, 1614.8385161483852, 1762.3567397899753, 1762.6122253104313, 7220.4945653804125, 7421.888671669929, 7463.925360746391, 7604.961975190124, 7621.161672216059, 7683.423743219253, 7753.379729621631, 7806.258405451473, 7830.138684744674, 7859.56772377519, 2292.793648571628, 2296.9310920672365, 2302.769723027692, 2303.2399308228246, 2315.120254303371, 2335.6496525521225, 2343.414146463384, 2369.680093187415, 2370.5732968065827, 2376.7504412036747, 2229.442639340165, 2262.9773702262933, 2276.0440614941763, 2284.326123793485, 2294.529621427612, 2273.6703178039174, 2279.4643258834326, 2283.109587260978, 2289.347535952254, 2296.7473577906417, 2311.167979527386, 2338.590746619335, 2338.847974881627, 2343.6250199968094, 2352.4706940938154, 7578.280063393969, 7585.317321441042, 7594.278543538355, 7615.35269502093, 7616.657250423744, 4699.036697477043, 4810.374651295344, 4832.710037397732, 4837.1776797944085, 4840.467548569654, 2960.970390296091, 2967.55486676998, 2997.070908018521, 3021.6676165621766, 3024.228821650487, 931.2643012020495, 956.1776871890169, 966.2849491376401, 988.9208863290919, 994.3089552760835, 10269.486525673761, 10295.742606434898, 10358.63744768937, 10411.53148108337, 10413.843792343121, 4228.534861165269, 4230.915381692349, 4235.767032813224, 4252.277112890816, 4379.386885835986, 8898.332625053146, 8931.106889311146, 8958.10418958099, 8961.507117108622, 9043.728688139367, 4791.233402655628, 4805.471398146201, 4827.589654879374, 4852.539008794159, 4864.22172452413, 4331.025519258142, 4341.956580434218, 4381.824727010884, 4410.272305069628, 4412.294032954712, 3578.7137029037613, 3597.94603080954, 3607.0801945503727, 3619.7104231661406, 3634.636536346344, 1163.2206421697483, 1167.6847251242286, 1170.8302296167178, 1183.5147589488267, 1186.483879512415, 956.7082039977735, 959.3380567408466, 1049.2812423489934, 1084.4415126210008, 1245.819356193347, 6980.0, 6981.05755722981, 7007.964960175166, 7021.824454388681, 7034.50758446914, 1092.874319453273, 1108.4623957380663, 1113.6102364172475, 1114.420501339299, 1138.5559631743627, 5493.176023596413, 5493.697846618395, 5513.173024046425, 5519.889602207933, 5552.250446189793, 8861.424007439497, 8918.10818918103, 9296.116868897443, 9316.114969078062, 9442.197413219816, 9210.493422861808, 9226.40028398152, 9232.815343693088, 9294.209992150743, 9353.345265831462, 6898.482613803984, 7116.430685545144, 7159.105111861018, 7175.533590316612, 7219.314165154302, 7023.929760702532, 7059.082319298458, 7085.929140708527, 7102.786916392516, 7134.60759658203, 7995.9200407997505, 8334.333253339839, 8351.373646976623, 8370.372222083246, 8489.10864359258, 8379.120192379956, 8682.088380719933, 8749.212570868653, 8750.47497150173, 8782.780430489034, 7181.245969173162, 7308.378787803096, 7321.267873212849, 7326.9267307326245, 7343.485955983244, 7416.888746668912, 7421.777346679608, 7422.035135432359, 7430.108386993596, 7512.586807725627, 6969.930300697131, 7047.823804404931, 7154.964225178841, 7277.417806575567, 7297.087864016998, 6054.212952316171, 6408.0, 6660.234073081658, 6681.265060843206, 6762.256151823394, 6891.75878844238, 6920.134983127109, 6921.169459664872, 6941.47938904574, 6948.096747422803, 6243.968780156252, 6249.9062514063235, 6264.21697287839, 6265.74937002533, 6282.528810339151, 6137.3862613738265, 6171.197744293213, 6195.473384762346, 6196.690165491617, 6207.906881396873], "unit": "score", "name": "mootools.html", "value": 4450.643431374814}, {"lowerIsBetter": false, "replicates": [315.6007650322343, 328.7205875006245, 335.414701346151, 338.36387591328315, 339.4822895084995, 6283.905741413871, 6297.0, 6368.04479328101, 6383.074454204143, 6406.775762848301, 6232.3144454110125, 6348.841278968017, 6355.71399287032, 6377.713002914868, 6383.106365108889, 4744.0511897620445, 4748.5014073522125, 4759.595434388081, 4763.214069678516, 4763.285507173917, 4763.975745214778, 4764.380630518028, 4765.166095933215, 4771.5467030632035, 4773.80904763809, 4642.558956899089, 4705.458872229703, 4715.457722361921, 4716.811327546911, 4730.0, 4654.4647365553055, 4706.623470122399, 4709.340692303081, 4713.575778179946, 4717.575418212377, 4018.7789671568053, 4070.0638853063665, 4072.572379900127, 4079.653229475498, 4092.508898932147, 5962.195103661037, 5966.552508561876, 5983.581149319506, 5999.550033747443, 6004.78983235589, 5369.40936496985, 5501.119820828648, 5508.283923089973, 5512.5589952803675, 5529.142982837667, 6631.568948018364, 6672.366125218096, 6674.16572928384, 6681.298463661343, 6710.060591517192, 4506.616937560311, 4523.909521809545, 4530.29780384041, 4534.455865296186, 4541.137183935075, 6807.183138023419, 6879.208890977501, 6915.239323674392, 6918.273581273995, 6985.511014229006, 4617.191991401492, 4620.099080679235, 4621.4223222097235, 4622.352870598119, 4641.466231383367, 4677.789499472532, 4679.298105284167, 4694.7887345068875, 4695.506971767915, 4700.341952126705, 5462.754176062087, 5473.534749546254, 5476.616636835463, 5484.287042684426, 5488.615796894179, 6544.363998079803, 6549.574277671936, 6629.635370054597, 6639.70121344531, 6700.095487109178, 1566.091666833234, 1569.1448160752418, 1570.3090640118312, 1574.6063484128968, 1642.24456749894, 1083.3012706804068, 1087.5812812067252, 1092.257265059751, 1098.0172745392988, 1098.2751384086464, 6237.594556353823, 6247.2815626202655, 6291.402316779899, 6293.779717709858, 6335.68321583919, 6754.189497260262, 6792.117024786845, 6804.285550017177, 6805.523613347018, 6821.658917054127, 6091.116788065706, 6175.0, 6220.440160385587, 6228.159198508143, 6268.780592679234, 3676.117731744362, 3692.538432695913, 3696.260747850387, 3703.0187000444903, 3703.7962912039557, 7084.752033678797, 7088.716451341992, 7096.53872498286, 7101.218865924744, 7107.609081500567, 6718.66406679664, 6939.410150137194, 6948.166220053525, 6953.165620125516, 6970.198427180838, 7056.7530136444975, 7091.376190809434, 7102.538335008311, 7126.394256488153, 7146.428285737024, 6797.0, 6799.524033317621, 6877.3810357068105, 6917.515773895779, 6930.965345173444, 6604.570702904296, 6672.299408562031, 6679.666016699242, 6708.966455167888, 6745.52781305304, 7045.225025247116, 7089.220185779457, 7115.5730656160795, 7115.608641524559, 7117.359437650636, 4627.375304333872, 4630.814767409266, 4632.4904260531985, 4637.25803871379, 4644.651651126247, 6698.83252918681, 6705.329467053256, 6792.117024786746, 6795.082663840516, 6928.965355173192, 6747.763828265987, 6816.420604248694, 6818.386345228953, 6833.4191593715095, 6847.760328388483, 6674.733010679518, 6708.060871477899, 6734.225564060196, 6734.56225345351, 6755.324467553205, 6396.552241343062, 6581.473482121514, 6608.570442921195, 6609.074729537965, 6617.172853393326, 6724.4284235840505, 6761.966190169018, 6765.526413151032, 6781.830454238683, 6788.864222715617, 6568.0, 6611.702473388806, 6621.073049772939, 6625.238097618835, 6632.104665870046], "unit": "score", "name": "prototype.html", "value": 4971.733458904253}, {"lowerIsBetter": false, "replicates": [811.2374368093991, 815.229608020421, 816.5335614190378, 821.2075347289866, 848.991510084899, 12852.485900563977, 12895.806562901553, 12996.675083122927, 13019.958403327722, 13031.869681303184, 10934.289271197367, 12302.261864288126, 12338.753224935495, 12403.689907752288, 12405.317707526105, 635.2821311917538, 779.8128449172215, 795.6817273090782, 796.9203079692013, 797.7965618767206, 791.0230864881867, 792.9524228546277, 796.2674339607546, 798.3533337996241, 801.0587559617455, 834.845553572588, 835.9289460395873, 838.325148255654, 838.8448137094626, 841.0538144587339, 822.4571782623469, 826.557791581501, 828.7348048624442, 830.667732906836, 832.2883934236202, 604.4499505450019, 606.2785285510229, 609.7652403824516, 610.1061944251649, 614.6588643302965, 12303.753924921451, 12330.568430104993, 12429.627111186679, 12436.937815310866, 12448.75102497954, 13029.478820847155, 13075.86924130756, 13076.803847942194, 13294.401751921187, 13373.264470454122, 10422.270441069128, 10503.789924201474, 10527.0, 10617.309874858187, 10633.202509811796, 3485.930281394383, 3488.4244099723514, 3524.1542029912894, 3629.4192929131214, 3648.3980143276326, 48003.5199648006, 48017.75991120057, 48335.274970875114, 48342.75828620869, 49623.2556511649, 9565.665201717906, 9964.551595178234, 10016.54925528353, 10041.246906481896, 10155.997312964973, 17408.47774566765, 17412.651746964988, 17444.127793610267, 17449.825501745076, 17490.91254543719, 7240.239774823673, 7402.629868506553, 7489.513181643176, 7594.734184303523, 7599.392048636096, 4277.443932288783, 4432.955670443319, 4456.821727130943, 4604.263317869125, 4616.28447590624, 2905.709429057077, 2974.1523665755158, 2975.0777259049764, 2976.5535169724712, 2976.583278341034, 527.0276340152412, 528.9365276166884, 542.5252903709254, 544.2842661899668, 545.0951420641716, 594.2482759309477, 596.8239369386041, 621.7761605821901, 645.9160309159779, 652.4128284543948, 8166.438858184188, 8213.589320534069, 8273.627686754111, 8424.53665048416, 8430.704925327584, 521.7625980179009, 531.5110098709197, 570.6661602962314, 632.4150161100963, 640.9776406631415, 3992.3612222044335, 4160.396742472324, 4224.5353011168745, 4276.893077673083, 4277.871663850089, 56740.71629641826, 57008.0, 57151.42848571544, 57216.0, 57315.14027289594, 52924.206136907975, 53352.733236333566, 53685.0, 53778.193327100125, 54641.726791365785, 45716.771416142044, 45886.12167016212, 46147.0, 46358.30462543065, 46436.0, 9014.954925225333, 9050.185483306534, 9381.343305968516, 9453.858192126985, 9481.620735170516, 33719.49420758642, 33752.32495350128, 33879.66120338765, 34006.0, 34319.0, 41668.37497437601, 41900.1619967605, 43147.0, 44353.55646443494, 44536.0, 11320.0, 11348.262362946381, 11376.431178441211, 11422.57217847769, 11444.313341199555, 12201.14591978553, 12476.750464990831, 12686.11197216186, 12824.86016159105, 13229.536966206137, 10904.836427453753, 10956.671299861016, 11087.778244434905, 11289.37908415045, 11694.0, 11410.372429516456, 11843.940780296043, 12016.819747703967, 12027.0, 12294.569690060805, 11461.942690286494, 11553.711157221136, 11565.537378505102, 11715.0, 11970.640880773592, 9586.952065239908, 9858.408495490294, 9858.698631843725, 9965.202783777426, 10153.39079655223, 9322.533873306444, 9661.0, 9753.60985560598, 9894.257930655374, 10393.480325983519], "unit": "score", "name": "yui.html", "value": 6260.372122042297}], "name": "dromaeo_css", "value": 6812.875333340491}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 113.0, 113.0, 112.0, 128.0, 113.0, 111.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 157.0, 160.0, 135.0, 155.0, 154.0, 131.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [165.0, 166.0, 164.0, 165.0, 164.0, 163.0, 162.0, 167.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 73.0, 75.0, 74.0, 75.0, 134.0, 74.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 97.0, 98.0, 96.0, 138.0, 97.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 98.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 59.0, 62.0, 62.0, 60.0, 60.0, 69.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 86.0, 84.0, 88.0, 84.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 121.0, 116.0, 124.0, 116.0, 125.0, 128.0, 128.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [146.0, 151.0, 164.0, 151.0, 151.0, 144.0, 151.0, 151.0, 150.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 71.0, 68.0, 73.0, 70.0, 67.0, 70.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1522.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [723.0657989877079], "unit": "score", "name": "Earley", "value": 921.718329}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [41080.0], "unit": "score", "name": "RegExp", "value": 22.175876338851033}, {"lowerIsBetter": false, "replicates": [633.3122229259025], "unit": "score", "name": "Splay", "value": 128.674289}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20168.540238844795}]} 07:27:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20168.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6812.87"}}} 07:27:27 INFO - Return code: 0 07:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:27:27 INFO - # TBPL SUCCESS # 07:27:27 INFO - Running post-action listener: _resource_record_post_action 07:27:27 INFO - Running post-run listener: _resource_record_post_run 07:27:29 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549531648; Read time: 268; Write time: 567888 07:27:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237457408; Read time: 268; Write time: 275116 07:27:29 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 312074240; Read time: 0; Write time: 292772 07:27:29 INFO - Running post-run listener: _upload_blobber_files 07:27:29 INFO - Blob upload gear active. 07:27:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:27:29 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 07:27:29 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'] 07:27:29 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 07:27:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:30 INFO - (blobuploader) - INFO - Done attempting. 07:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:31 INFO - (blobuploader) - INFO - Done attempting. 07:27:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:31 INFO - Return code: 0 07:27:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:27:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5be7329c8da7dc4b7704c99fa4e3de50a6a3d9120d47bb6629a09f442c8ae8311345c55e487d76076b9f661b9a44eac7e133ca181e7aca63c4bc2ceafe5ae938", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eec3ee6a282a75cbafe81606c131aeb1b0f16935514b8bd9ed7bfc5c9caf00189464265acbb992bb6cba8eff97000dd1317dbbc6c9f0500395638bd829ff5aa3"} 07:27:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:27:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:27:31 INFO - Contents: 07:27:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5be7329c8da7dc4b7704c99fa4e3de50a6a3d9120d47bb6629a09f442c8ae8311345c55e487d76076b9f661b9a44eac7e133ca181e7aca63c4bc2ceafe5ae938", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eec3ee6a282a75cbafe81606c131aeb1b0f16935514b8bd9ed7bfc5c9caf00189464265acbb992bb6cba8eff97000dd1317dbbc6c9f0500395638bd829ff5aa3"} 07:27:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:31 INFO - Copying logs to upload dir... 07:27:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:27:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.986510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-19 07:27:28.967672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:28.970781) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 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/5be7329c8da7dc4b7704c99fa4e3de50a6a3d9120d47bb6629a09f442c8ae8311345c55e487d76076b9f661b9a44eac7e133ca181e7aca63c4bc2ceafe5ae938", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eec3ee6a282a75cbafe81606c131aeb1b0f16935514b8bd9ed7bfc5c9caf00189464265acbb992bb6cba8eff97000dd1317dbbc6c9f0500395638bd829ff5aa3"} build_url:https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/SGzJ9fNwQ0CBnlnA3LW6bQ/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/5be7329c8da7dc4b7704c99fa4e3de50a6a3d9120d47bb6629a09f442c8ae8311345c55e487d76076b9f661b9a44eac7e133ca181e7aca63c4bc2ceafe5ae938", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/eec3ee6a282a75cbafe81606c131aeb1b0f16935514b8bd9ed7bfc5c9caf00189464265acbb992bb6cba8eff97000dd1317dbbc6c9f0500395638bd829ff5aa3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:28.995884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:28.996260) ========= 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=fa44defc139c4ba8574fe040000001db-1453210171.160453-1427446002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:29.079856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 07:27:29.080500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 07:27:29.080997) ========= ========= Total master_lag: 1.46 =========