builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1453154652.42 results: success (0) buildid: 20160118113022 builduid: d1d69651fabc482fa587fb88814c7fe4 revision: 5130acda2500ae9798efee4e668e9d96c1ebfc9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.419307) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.419959) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.420457) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.454683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.455009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.506700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.507008) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.039856 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.557729) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.558056) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.558450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.558786) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 14:04:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.0M=0s 2016-01-18 14:04:12 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159534 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.741961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.742292) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.136200 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.890065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:12.890414) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 5130acda2500ae9798efee4e668e9d96c1ebfc9e --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/b2g-inbound --rev 5130acda2500ae9798efee4e668e9d96c1ebfc9e --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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 14:04:12,996 truncating revision to first 12 chars 2016-01-18 14:04:12,996 Setting DEBUG logging. 2016-01-18 14:04:12,996 attempt 1/10 2016-01-18 14:04:12,996 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/5130acda2500?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 14:04:13,269 unpacking tar archive at: b2g-inbound-5130acda2500/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560418 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.467334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.468166) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004674 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.526491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.526825) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.537962) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.538493) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 14:04:13.539261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-18 14:04:13.539882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:13 INFO - MultiFileLogger online at 20160118 14:04:13 in /builds/slave/test-pgo 14:04:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 14:04:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:04:13 INFO - {'append_to_log': False, 14:04:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:04:13 INFO - 'blob_upload_branch': 'B2G-Inbound', 14:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:04:13 INFO - 'branch': 'B2G-Inbound', 14:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:13 INFO - 'config_files': ('talos/linux_config.py',), 14:04:13 INFO - 'default_actions': ('clobber', 14:04:13 INFO - 'read-buildbot-config', 14:04:13 INFO - 'download-and-extract', 14:04:13 INFO - 'populate-webroot', 14:04:13 INFO - 'create-virtualenv', 14:04:13 INFO - 'install', 14:04:13 INFO - 'run-tests'), 14:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:13 INFO - 'download_minidump_stackwalk': True, 14:04:13 INFO - 'download_symbols': 'ondemand', 14:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:13 INFO - 'installer_path': 'installer.exe', 14:04:13 INFO - 'log_level': 'info', 14:04:13 INFO - 'log_name': 'talos', 14:04:13 INFO - 'log_to_console': True, 14:04:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:13 INFO - 'opt_config_files': (), 14:04:13 INFO - 'pip_index': False, 14:04:13 INFO - 'sps_profile': False, 14:04:13 INFO - 'sps_profile_interval': 0, 14:04:13 INFO - 'suite': 'dromaeojs', 14:04:13 INFO - 'system_bits': '32', 14:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:13 INFO - 'title': 'talos-linux64-ix-025', 14:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:13 INFO - 'use_talos_json': True, 14:04:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:13 INFO - 'work_dir': 'build'} 14:04:13 INFO - ##### 14:04:13 INFO - ##### Running clobber step. 14:04:13 INFO - ##### 14:04:13 INFO - Running pre-action listener: _resource_record_pre_action 14:04:13 INFO - Running main action method: clobber 14:04:13 INFO - rmtree: /builds/slave/test-pgo/build 14:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:04:14 INFO - Running post-action listener: _resource_record_post_action 14:04:14 INFO - ##### 14:04:14 INFO - ##### Running read-buildbot-config step. 14:04:14 INFO - ##### 14:04:14 INFO - Running pre-action listener: _resource_record_pre_action 14:04:14 INFO - Running main action method: read_buildbot_config 14:04:14 INFO - Using buildbot properties: 14:04:14 INFO - { 14:04:14 INFO - "project": "", 14:04:14 INFO - "product": "firefox", 14:04:14 INFO - "script_repo_revision": "production", 14:04:14 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 14:04:14 INFO - "repository": "", 14:04:14 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 14:04:14 INFO - "buildid": "20160118113022", 14:04:14 INFO - "pgo_build": "True", 14:04:14 INFO - "basedir": "/builds/slave/test-pgo", 14:04:14 INFO - "buildnumber": 213, 14:04:14 INFO - "slavename": "talos-linux64-ix-025", 14:04:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:04:14 INFO - "platform": "ubuntu64_hw", 14:04:14 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 14:04:14 INFO - "branch": "b2g-inbound", 14:04:14 INFO - "repo_path": "integration/b2g-inbound", 14:04:14 INFO - "revision": "5130acda2500ae9798efee4e668e9d96c1ebfc9e", 14:04:14 INFO - "stage_platform": "linux64-pgo", 14:04:14 INFO - "builduid": "d1d69651fabc482fa587fb88814c7fe4", 14:04:14 INFO - "slavebuilddir": "test" 14:04:14 INFO - } 14:04:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:04:14 INFO - Running post-action listener: _resource_record_post_action 14:04:14 INFO - ##### 14:04:14 INFO - ##### Running download-and-extract step. 14:04:14 INFO - ##### 14:04:14 INFO - Running pre-action listener: _resource_record_pre_action 14:04:14 INFO - Running main action method: download_and_extract 14:04:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:04: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')]} 14:04:14 INFO - https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/test_packages.json 14:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/test_packages.json 14:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:04:19 INFO - Downloaded 1448 bytes. 14:04:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:04:19 INFO - Using the following test package requirements: 14:04:19 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:19 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:19 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:04:19 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'jsshell-linux-x86_64.zip'], 14:04:19 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:19 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:19 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:19 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:19 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:19 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:19 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:19 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04: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')]} 14:04:19 INFO - https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:23 INFO - Downloaded 22484099 bytes. 14:04:23 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'] 14:04:23 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 14:04:24 INFO - Return code: 0 14:04:24 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 14:04:24 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')]} 14:04:24 INFO - https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:27 INFO - Downloaded 22484099 bytes. 14:04: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'] 14:04: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 14:04:29 INFO - Return code: 0 14:04:29 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')]} 14:04:29 INFO - https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:31 INFO - Downloaded 11132144 bytes. 14:04:31 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'] 14:04:31 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 14:04:31 INFO - Return code: 0 14:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:31 INFO - https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WvebXX7JQSuLS6NZsCAt1g/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 14:04:34 INFO - Downloaded 55925946 bytes. 14:04:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:34 INFO - mkdir: /builds/slave/test-pgo/properties 14:04:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:04:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:04:34 INFO - Contents: 14:04:34 INFO - build_url:https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:34 INFO - Running post-action listener: _resource_record_post_action 14:04:34 INFO - Running post-action listener: set_extra_try_arguments 14:04:34 INFO - ##### 14:04:34 INFO - ##### Running populate-webroot step. 14:04:34 INFO - ##### 14:04:34 INFO - Running pre-action listener: _resource_record_pre_action 14:04:34 INFO - Running main action method: populate_webroot 14:04:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:34 INFO - '--tppagecycles', 14:04:34 INFO - '7'], 14:04:34 INFO - 'tests': ['tsvgm']}}, 14:04:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'tests': ['damp', 'tps']}, 14:04:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['damp', 'tps']}, 14:04:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:34 INFO - 'other': {'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'other_l64': {'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:34 INFO - 'ts_paint', 14:04:34 INFO - 'tpaint', 14:04:34 INFO - 'sessionrestore', 14:04:34 INFO - 'sessionrestore_no_auto_restore']}, 14:04:34 INFO - 'svgr': {'tests': ['tsvgx', 14:04:34 INFO - 'tsvgr_opacity', 14:04:34 INFO - 'tart', 14:04:34 INFO - 'tscrollx', 14:04:34 INFO - 'cart']}, 14:04:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['tsvgx', 14:04:34 INFO - 'tsvgr_opacity', 14:04:34 INFO - 'tart', 14:04:34 INFO - 'tscrollx', 14:04:34 INFO - 'cart']}, 14:04:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'tests': ['tp5o']}, 14:04:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'talos_options': ['--e10s'], 14:04:34 INFO - 'tests': ['tp5o']}, 14:04:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'talos_options': ['--xperf_path', 14:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:34 INFO - 'tests': ['tp5n']}, 14:04:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:34 INFO - 'talos_options': ['--e10s', 14:04:34 INFO - '--xperf_path', 14:04:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:34 INFO - 'tests': ['tp5n']}}, 14:04:34 INFO - 'talos.zip': {'path': '', 14:04:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:34 INFO - Running post-action listener: _resource_record_post_action 14:04:34 INFO - ##### 14:04:34 INFO - ##### Running create-virtualenv step. 14:04:34 INFO - ##### 14:04:34 INFO - Running pre-action listener: _resource_record_pre_action 14:04:34 INFO - Running main action method: create_virtualenv 14:04:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:04: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 14:04:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:04:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:34 INFO - Using real prefix '/usr' 14:04:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:04:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:04:37 INFO - Installing pip.................done. 14:04:37 INFO - Return code: 0 14:04:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:37 INFO - Using env: {'DISPLAY': ':0', 14:04:37 INFO - 'HOME': '/home/cltbld', 14:04:37 INFO - 'LANG': 'en_US.UTF-8', 14:04:37 INFO - 'LANGUAGE': 'en_US:en', 14:04:37 INFO - 'LOGNAME': 'cltbld', 14:04:37 INFO - 'MAIL': '/var/mail/cltbld', 14:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:37 INFO - 'MOZ_NO_REMOTE': '1', 14:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:37 INFO - 'NO_EM_RESTART': '1', 14:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:37 INFO - 'SHELL': '/bin/bash', 14:04:37 INFO - 'SHLVL': '1', 14:04:37 INFO - 'TERM': 'linux', 14:04:37 INFO - 'TMOUT': '86400', 14:04:37 INFO - 'USER': 'cltbld', 14:04:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:37 INFO - '_': '/tools/buildbot/bin/python'} 14:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04: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 14:04:37 INFO - Cleaning up... 14:04:37 INFO - Return code: 0 14:04:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:37 INFO - Using env: {'DISPLAY': ':0', 14:04:37 INFO - 'HOME': '/home/cltbld', 14:04:37 INFO - 'LANG': 'en_US.UTF-8', 14:04:37 INFO - 'LANGUAGE': 'en_US:en', 14:04:37 INFO - 'LOGNAME': 'cltbld', 14:04:37 INFO - 'MAIL': '/var/mail/cltbld', 14:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:37 INFO - 'MOZ_NO_REMOTE': '1', 14:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:37 INFO - 'NO_EM_RESTART': '1', 14:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:37 INFO - 'SHELL': '/bin/bash', 14:04:37 INFO - 'SHLVL': '1', 14:04:37 INFO - 'TERM': 'linux', 14:04:37 INFO - 'TMOUT': '86400', 14:04:37 INFO - 'USER': 'cltbld', 14:04:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:37 INFO - '_': '/tools/buildbot/bin/python'} 14:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:37 INFO - Downloading/unpacking psutil>=0.7.1 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:04:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:04:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:39 INFO - Installing collected packages: psutil 14:04:39 INFO - Running setup.py install for psutil 14:04:39 INFO - building 'psutil._psutil_linux' extension 14:04: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 14:04: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 14:04:39 INFO - building 'psutil._psutil_posix' extension 14:04: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 14:04: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 14:04:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:04:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:04:39 INFO - Successfully installed psutil 14:04:39 INFO - Cleaning up... 14:04:40 INFO - Return code: 0 14:04:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:40 INFO - Using env: {'DISPLAY': ':0', 14:04:40 INFO - 'HOME': '/home/cltbld', 14:04:40 INFO - 'LANG': 'en_US.UTF-8', 14:04:40 INFO - 'LANGUAGE': 'en_US:en', 14:04:40 INFO - 'LOGNAME': 'cltbld', 14:04:40 INFO - 'MAIL': '/var/mail/cltbld', 14:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:40 INFO - 'MOZ_NO_REMOTE': '1', 14:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:40 INFO - 'NO_EM_RESTART': '1', 14:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:40 INFO - 'SHELL': '/bin/bash', 14:04:40 INFO - 'SHLVL': '1', 14:04:40 INFO - 'TERM': 'linux', 14:04:40 INFO - 'TMOUT': '86400', 14:04:40 INFO - 'USER': 'cltbld', 14:04:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:40 INFO - '_': '/tools/buildbot/bin/python'} 14:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:04:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:04:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:04: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) 14:04:42 INFO - Installing collected packages: mozsystemmonitor 14:04:42 INFO - Running setup.py install for mozsystemmonitor 14:04:42 INFO - Successfully installed mozsystemmonitor 14:04:42 INFO - Cleaning up... 14:04:42 INFO - Return code: 0 14:04:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:42 INFO - Using env: {'DISPLAY': ':0', 14:04:42 INFO - 'HOME': '/home/cltbld', 14:04:42 INFO - 'LANG': 'en_US.UTF-8', 14:04:42 INFO - 'LANGUAGE': 'en_US:en', 14:04:42 INFO - 'LOGNAME': 'cltbld', 14:04:42 INFO - 'MAIL': '/var/mail/cltbld', 14:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:42 INFO - 'MOZ_NO_REMOTE': '1', 14:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:42 INFO - 'NO_EM_RESTART': '1', 14:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:42 INFO - 'SHELL': '/bin/bash', 14:04:42 INFO - 'SHLVL': '1', 14:04:42 INFO - 'TERM': 'linux', 14:04:42 INFO - 'TMOUT': '86400', 14:04:42 INFO - 'USER': 'cltbld', 14:04:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:42 INFO - '_': '/tools/buildbot/bin/python'} 14:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:04:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:04:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:04:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:04:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:04:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:45 INFO - Downloading docopt-0.6.1.tar.gz 14:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:04:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:04:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:04:45 INFO - Running setup.py install for blobuploader 14:04:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:04:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:04:45 INFO - Running setup.py install for requests 14:04:45 INFO - Running setup.py install for docopt 14:04:45 INFO - Successfully installed blobuploader requests docopt 14:04:45 INFO - Cleaning up... 14:04:45 INFO - Return code: 0 14:04:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:45 INFO - Using env: {'DISPLAY': ':0', 14:04:45 INFO - 'HOME': '/home/cltbld', 14:04:45 INFO - 'LANG': 'en_US.UTF-8', 14:04:45 INFO - 'LANGUAGE': 'en_US:en', 14:04:45 INFO - 'LOGNAME': 'cltbld', 14:04:45 INFO - 'MAIL': '/var/mail/cltbld', 14:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:45 INFO - 'MOZ_NO_REMOTE': '1', 14:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:45 INFO - 'NO_EM_RESTART': '1', 14:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:45 INFO - 'SHELL': '/bin/bash', 14:04:45 INFO - 'SHLVL': '1', 14:04:45 INFO - 'TERM': 'linux', 14:04:45 INFO - 'TMOUT': '86400', 14:04:45 INFO - 'USER': 'cltbld', 14:04:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:45 INFO - '_': '/tools/buildbot/bin/python'} 14:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:46 INFO - Running setup.py (path:/tmp/pip-krDSls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:46 INFO - Running setup.py (path:/tmp/pip-HSWtoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:46 INFO - Running setup.py (path:/tmp/pip-HkF3V8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:46 INFO - Running setup.py (path:/tmp/pip-EwNOeW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:46 INFO - Running setup.py (path:/tmp/pip-IlEoQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:46 INFO - Running setup.py (path:/tmp/pip-kl20sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:46 INFO - Running setup.py (path:/tmp/pip-xDrqml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:46 INFO - Running setup.py (path:/tmp/pip-TpHMKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:46 INFO - Running setup.py (path:/tmp/pip-wQGmGr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:46 INFO - Running setup.py (path:/tmp/pip-BLtXpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:46 INFO - Running setup.py (path:/tmp/pip-o4smXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:46 INFO - Running setup.py (path:/tmp/pip-10fqcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:46 INFO - Running setup.py (path:/tmp/pip-fTGtl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:46 INFO - Running setup.py (path:/tmp/pip-2I1zhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:47 INFO - Running setup.py (path:/tmp/pip-nJPsvr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:47 INFO - Running setup.py (path:/tmp/pip-oLLdOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:47 INFO - Running setup.py (path:/tmp/pip-YjHEm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:04:47 INFO - Running setup.py install for manifestparser 14:04:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozcrash 14:04:47 INFO - Running setup.py install for mozdebug 14:04:47 INFO - Running setup.py install for mozdevice 14:04:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozfile 14:04:47 INFO - Running setup.py install for mozhttpd 14:04:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozinfo 14:04:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Running setup.py install for mozInstall 14:04:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:04:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozleak 14:04:48 INFO - Running setup.py install for mozlog 14:04:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for moznetwork 14:04:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozprocess 14:04:48 INFO - Running setup.py install for mozprofile 14:04:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozrunner 14:04:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Running setup.py install for mozscreenshot 14:04:48 INFO - Running setup.py install for moztest 14:04:48 INFO - Running setup.py install for mozversion 14:04:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:04:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:04:48 INFO - Cleaning up... 14:04:48 INFO - Return code: 0 14:04:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:48 INFO - Using env: {'DISPLAY': ':0', 14:04:48 INFO - 'HOME': '/home/cltbld', 14:04:48 INFO - 'LANG': 'en_US.UTF-8', 14:04:48 INFO - 'LANGUAGE': 'en_US:en', 14:04:48 INFO - 'LOGNAME': 'cltbld', 14:04:48 INFO - 'MAIL': '/var/mail/cltbld', 14:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:48 INFO - 'MOZ_NO_REMOTE': '1', 14:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:48 INFO - 'NO_EM_RESTART': '1', 14:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:48 INFO - 'SHELL': '/bin/bash', 14:04:48 INFO - 'SHLVL': '1', 14:04:48 INFO - 'TERM': 'linux', 14:04:48 INFO - 'TMOUT': '86400', 14:04:48 INFO - 'USER': 'cltbld', 14:04:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:48 INFO - '_': '/tools/buildbot/bin/python'} 14:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04:49 INFO - Running setup.py (path:/tmp/pip-4HuKZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04:49 INFO - Running setup.py (path:/tmp/pip-aB9g59-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04:49 INFO - Running setup.py (path:/tmp/pip-gJB9qw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04:49 INFO - Running setup.py (path:/tmp/pip-bosUM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04:49 INFO - Running setup.py (path:/tmp/pip-4_JL46-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04:49 INFO - Running setup.py (path:/tmp/pip-UIpI2v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04:49 INFO - Running setup.py (path:/tmp/pip-JI7DCG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04:49 INFO - Running setup.py (path:/tmp/pip-dUrcQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04:49 INFO - Running setup.py (path:/tmp/pip-dcqANQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04:49 INFO - Running setup.py (path:/tmp/pip-rfboxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04:49 INFO - Running setup.py (path:/tmp/pip-ijquS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:04: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)) 14:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:49 INFO - Running setup.py (path:/tmp/pip-rTpKY2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:04:50 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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04:50 INFO - Running setup.py (path:/tmp/pip-efNKa4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:04: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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04:50 INFO - Running setup.py (path:/tmp/pip-4GU_Yf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:04: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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04:50 INFO - Running setup.py (path:/tmp/pip-TcHQSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:04: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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:04:50 INFO - Running setup.py (path:/tmp/pip-AoewOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:04: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)) 14:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04:50 INFO - Running setup.py (path:/tmp/pip-bp2BhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:52 INFO - Downloading blessings-1.5.1.tar.gz 14:04:52 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 14:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:04:52 INFO - Installing collected packages: blessings 14:04:52 INFO - Running setup.py install for blessings 14:04:52 INFO - Successfully installed blessings 14:04:52 INFO - Cleaning up... 14:04:52 INFO - Return code: 0 14:04:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:04:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:04:52 INFO - Reading from file tmpfile_stdout 14:04:52 INFO - Current package versions: 14:04:52 INFO - argparse == 1.2.1 14:04:52 INFO - blessings == 1.5.1 14:04:52 INFO - blobuploader == 1.2.4 14:04:52 INFO - docopt == 0.6.1 14:04:52 INFO - manifestparser == 1.1 14:04:52 INFO - mozInstall == 1.12 14:04:52 INFO - mozcrash == 0.16 14:04:52 INFO - mozdebug == 0.1 14:04:52 INFO - mozdevice == 0.48 14:04:52 INFO - mozfile == 1.2 14:04:52 INFO - mozhttpd == 0.7 14:04:52 INFO - mozinfo == 0.9 14:04:52 INFO - mozleak == 0.1 14:04:52 INFO - mozlog == 3.1 14:04:52 INFO - moznetwork == 0.27 14:04:52 INFO - mozprocess == 0.22 14:04:52 INFO - mozprofile == 0.28 14:04:52 INFO - mozrunner == 6.11 14:04:52 INFO - mozscreenshot == 0.1 14:04:52 INFO - mozsystemmonitor == 0.0 14:04:52 INFO - moztest == 0.7 14:04:52 INFO - mozversion == 1.4 14:04:52 INFO - psutil == 3.1.1 14:04:52 INFO - requests == 1.2.3 14:04:52 INFO - wsgiref == 0.1.2 14:04:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:52 INFO - Using env: {'DISPLAY': ':0', 14:04:52 INFO - 'HOME': '/home/cltbld', 14:04:52 INFO - 'LANG': 'en_US.UTF-8', 14:04:52 INFO - 'LANGUAGE': 'en_US:en', 14:04:52 INFO - 'LOGNAME': 'cltbld', 14:04:52 INFO - 'MAIL': '/var/mail/cltbld', 14:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:52 INFO - 'MOZ_NO_REMOTE': '1', 14:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:52 INFO - 'NO_EM_RESTART': '1', 14:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:52 INFO - 'SHELL': '/bin/bash', 14:04:52 INFO - 'SHLVL': '1', 14:04:52 INFO - 'TERM': 'linux', 14:04:52 INFO - 'TMOUT': '86400', 14:04:52 INFO - 'USER': 'cltbld', 14:04:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:52 INFO - '_': '/tools/buildbot/bin/python'} 14:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04: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)) 14:04:52 INFO - Cleaning up... 14:04:52 INFO - Return code: 0 14:04:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:52 INFO - Using env: {'DISPLAY': ':0', 14:04:52 INFO - 'HOME': '/home/cltbld', 14:04:52 INFO - 'LANG': 'en_US.UTF-8', 14:04:52 INFO - 'LANGUAGE': 'en_US:en', 14:04:52 INFO - 'LOGNAME': 'cltbld', 14:04:52 INFO - 'MAIL': '/var/mail/cltbld', 14:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:52 INFO - 'MOZ_NO_REMOTE': '1', 14:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:52 INFO - 'NO_EM_RESTART': '1', 14:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:52 INFO - 'SHELL': '/bin/bash', 14:04:52 INFO - 'SHLVL': '1', 14:04:52 INFO - 'TERM': 'linux', 14:04:52 INFO - 'TMOUT': '86400', 14:04:52 INFO - 'USER': 'cltbld', 14:04:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:52 INFO - '_': '/tools/buildbot/bin/python'} 14:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:53 INFO - Downloading/unpacking jsonschema 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:04:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:04: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 14:04:54 INFO - Downloading/unpacking functools32 (from jsonschema) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:04: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 14:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:04:54 INFO - warning: no files found matching '*.txt' 14:04:54 INFO - no previously-included directories found matching 'build' 14:04:54 INFO - no previously-included directories found matching 'dist' 14:04:54 INFO - no previously-included directories found matching '.git*' 14:04:54 INFO - Installing collected packages: jsonschema, functools32 14:04:55 INFO - Running setup.py install for functools32 14:04:55 INFO - warning: no files found matching '*.txt' 14:04:55 INFO - no previously-included directories found matching 'build' 14:04:55 INFO - no previously-included directories found matching 'dist' 14:04:55 INFO - no previously-included directories found matching '.git*' 14:04:55 INFO - Successfully installed jsonschema functools32 14:04:55 INFO - Cleaning up... 14:04:55 INFO - Return code: 0 14:04:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:04: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')]} 14:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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')]} 14:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:04: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 0x7f72637c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, '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': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', '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 14:04: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 14:04: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 14:04:55 INFO - Using env: {'DISPLAY': ':0', 14:04:55 INFO - 'HOME': '/home/cltbld', 14:04:55 INFO - 'LANG': 'en_US.UTF-8', 14:04:55 INFO - 'LANGUAGE': 'en_US:en', 14:04:55 INFO - 'LOGNAME': 'cltbld', 14:04:55 INFO - 'MAIL': '/var/mail/cltbld', 14:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:55 INFO - 'MOZ_NO_REMOTE': '1', 14:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:55 INFO - 'NO_EM_RESTART': '1', 14:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:55 INFO - 'SHELL': '/bin/bash', 14:04:55 INFO - 'SHLVL': '1', 14:04:55 INFO - 'TERM': 'linux', 14:04:55 INFO - 'TMOUT': '86400', 14:04:55 INFO - 'USER': 'cltbld', 14:04:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:55 INFO - '_': '/tools/buildbot/bin/python'} 14:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:04:55 INFO - Downloading/unpacking flake8 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:04:57 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 14:04:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:04: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 14:04:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04: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 14:04:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:04:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:04:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:04:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:04:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:04:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:04:57 INFO - no previously-included directories found matching 'docs/_build' 14:04:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:04:57 INFO - Running setup.py install for pep8 14:04:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:04:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:04:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:04:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:04:57 INFO - no previously-included directories found matching 'docs/_build' 14:04:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:04:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:04:57 INFO - Cleaning up... 14:04:57 INFO - Return code: 0 14:04:57 INFO - Running post-action listener: _resource_record_post_action 14:04:57 INFO - Running post-action listener: _start_resource_monitoring 14:04:58 INFO - Starting resource monitoring. 14:04:58 INFO - ##### 14:04:58 INFO - ##### Running install step. 14:04:58 INFO - ##### 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: install 14:04:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:04:58 INFO - Reading from file tmpfile_stdout 14:04:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:04:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:04:58 INFO - Reading from file tmpfile_stdout 14:04:58 INFO - Output received: 14:04:58 INFO - Usage: mozinstall [options] installer 14:04:58 INFO - Options: 14:04:58 INFO - -h, --help show this help message and exit 14:04:58 INFO - -d DEST, --destination=DEST 14:04:58 INFO - Directory to install application into. [default: 14:04:58 INFO - "/builds/slave/test-pgo"] 14:04:58 INFO - --app=APP Application being installed. [default: firefox] 14:04:58 INFO - mkdir: /builds/slave/test-pgo/build/application 14:04: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'] 14:04: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 14:05:14 INFO - Reading from file tmpfile_stdout 14:05:14 INFO - Output received: 14:05:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:05:14 INFO - Running post-action listener: _resource_record_post_action 14:05:14 INFO - ##### 14:05:14 INFO - ##### Running run-tests step. 14:05:14 INFO - ##### 14:05:14 INFO - Running pre-action listener: _resource_record_pre_action 14:05:14 INFO - Running main action method: run_tests 14:05:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:05:14 INFO - Python 2.7.3 14:05:14 INFO - Return code: 0 14:05:14 INFO - grabbing minidump binary from tooltool 14:05: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')]} 14:05: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 0x28cf840>, '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 0x283c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:05: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 14:05: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 14:05:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:14 INFO - Return code: 0 14:05:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:05:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:05:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:05:15 INFO - Return code: 0 14:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:05:15 INFO - Using env: {'DISPLAY': ':0', 14:05:15 INFO - 'HOME': '/home/cltbld', 14:05:15 INFO - 'LANG': 'en_US.UTF-8', 14:05:15 INFO - 'LANGUAGE': 'en_US:en', 14:05:15 INFO - 'LOGNAME': 'cltbld', 14:05:15 INFO - 'MAIL': '/var/mail/cltbld', 14:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:15 INFO - 'MOZ_NO_REMOTE': '1', 14:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:15 INFO - 'NO_EM_RESTART': '1', 14:05:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:05:15 INFO - 'SHELL': '/bin/bash', 14:05:15 INFO - 'SHLVL': '1', 14:05:15 INFO - 'TERM': 'linux', 14:05:15 INFO - 'TMOUT': '86400', 14:05:15 INFO - 'USER': 'cltbld', 14:05:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357', 14:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:15 INFO - '_': '/tools/buildbot/bin/python'} 14:05:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:05:15 INFO - mozversion application_buildid: 20160118113022 14:05:15 INFO - mozversion application_changeset: 5130acda2500ae9798efee4e668e9d96c1ebfc9e 14:05:15 INFO - mozversion application_display_name: Nightly 14:05:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:15 INFO - mozversion application_name: Firefox 14:05:15 INFO - mozversion application_remotingname: firefox 14:05:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 14:05:15 INFO - mozversion application_vendor: Mozilla 14:05:15 INFO - mozversion application_version: 46.0a1 14:05:15 INFO - mozversion platform_buildid: 20160118113022 14:05:15 INFO - mozversion platform_changeset: 5130acda2500ae9798efee4e668e9d96c1ebfc9e 14:05:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 14:05:15 INFO - mozversion platform_version: 46.0a1 14:05:15 INFO - using testdate: 1453154715 14:05:15 INFO - actual date: 1453154715 14:05:15 INFO - starting webserver on 'localhost:33657' 14:05:15 INFO - SUITE-START | Running 3 tests 14:05:15 INFO - TEST-START | dromaeo_css 14:05:15 INFO - operating with platform_type : linux_ 14:05:15 INFO - Initialising browser for dromaeo_css test... 14:05:15 INFO - TEST-INFO | started process 5440 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcFPGPh/profile http://localhost:33657/getInfo.html) 14:05:20 INFO - PROCESS | 5440 | __metrics Screen width/height:1600/1200 14:05:20 INFO - PROCESS | 5440 | colorDepth:24 14:05:20 INFO - PROCESS | 5440 | Browser inner width/height: 1024/697 14:05:20 INFO - PROCESS | 5440 | __metrics 14:05:20 INFO - PROCESS | 5440 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:20 INFO - PROCESS | 5440 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:21 INFO - TEST-INFO | 5440: exit 0 14:05:21 INFO - Browser initialized. 14:05:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:21 INFO - TEST-INFO | started process 5536 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcFPGPh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:32 INFO - PROCESS | 5536 | RSS: Main: 149446656 14:05:32 INFO - PROCESS | 5536 | 14:06:24 INFO - PROCESS | 5536 | 1453154784198 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] 14:08:32 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33657/tests/dromaeo/cssquery-ext.html) 14:08:33 INFO - PROCESS | 5536 | RSS: Main: 231124992 14:08:33 INFO - PROCESS | 5536 | 14:11:35 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-ext.html (next: http://localhost:33657/tests/dromaeo/cssquery-jquery.html) 14:11:35 INFO - PROCESS | 5536 | RSS: Main: 224788480 14:11:35 INFO - PROCESS | 5536 | 14:14:37 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33657/tests/dromaeo/cssquery-mootools.html) 14:14:38 INFO - PROCESS | 5536 | RSS: Main: 234291200 14:14:38 INFO - PROCESS | 5536 | 14:17:40 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33657/tests/dromaeo/cssquery-prototype.html) 14:17:41 INFO - PROCESS | 5536 | RSS: Main: 211726336 14:17:41 INFO - PROCESS | 5536 | 14:20:43 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33657/tests/dromaeo/cssquery-yui.html) 14:20:44 INFO - PROCESS | 5536 | RSS: Main: 216326144 14:20:44 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | Cycle 1(1): loaded http://localhost:33657/tests/dromaeo/cssquery-yui.html (next: http://localhost:33657/tests/dromaeo/cssquery-dojo.html) 14:23:46 INFO - PROCESS | 5536 | RSS: Main: 293990400 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | __start_tp_report 14:23:46 INFO - PROCESS | 5536 | _x_x_mozilla_page_load 14:23:46 INFO - PROCESS | 5536 | _x_x_mozilla_page_load_details 14:23:46 INFO - PROCESS | 5536 | |i|pagename|runs| 14:23:46 INFO - PROCESS | 5536 | |0;dojo.html;3112.0663800859743;3117.984410077949;3164.794288371256;3165.9683403165964;3188.2029492626843;4941.851744447663;5000.3499545059185;5015.423226328973;5042.571381432578;5079.619028572858;5032.245163225518;5071.264666623347;5072.898542029157;5077.720725360104;5086.313347698059;4406.625436837857;4569.200389931765;4578.084383123381;4629.305604159369;4721.220998535255;4491.663125265602;4635.258358662614;4670.229412146991;4679.064187162564;4712.6229901607785;4521.999999999984;4551.522090180533;4596.448426188862;4610.031893302411;4628.1669299526075;4574.153781550423;4574.72551646899;4576.519465456146;4585.770711464447;4609.815607375701;4557.95442045582;4576.794044268016;4578.587927086545;4610.446746390421;4611.5619016193405;4815.518448155157;4821.252705830567;4864.756762161877;4889.779959901813;4910.361652985089;5402.054640437907;5426.701531415771;5436.592255580847;5445.019896418643;5451.700156491392;5370;5470.91793623096;5478.671279723189;5482.91775623366;5535.58483113764;4996.2505624156665;5038.118329292359;5083.466236045236;5126.205438157129;5127.692338459704;5559.77760889568;5581.5813813963305;5594.748236329375;5597.132444471114;5648.915266271009;5245.737713114329;5385.8114965976;5394.406615272317;5396.055690254189;5399.811006614828;5331.226972089025;5360.65155764874;5364.436734142859;5415.945840541623;5436.130219164915;5354.973225133849;5368.0605893968395;5371.57027437804;5375.973120134452;5378.044293286357;5198.6880787152895;5305.363356397257;5380.892382152335;5391.406945236021;5427.023135835509;4206.41110244566;4213.620774130343;4222.345536441856;4224.852130175491;4253.48958125027;3796.5823759386444;3799.3920972644796;3810.8666196682984;3816.580176180618;3838.2131663009573;4980.975095124573;5002.199648056294;5059.266406371129;5065.898682026413;5084.262781896604;5361.571074314045;5371.113766228606;5401.837944861661;5410.107332290207;5452.645578037414;4958.429780575208;4966.826161084345;4967.304577359173;4974.602031837444;5017.297578339036;4558.270676691714;4595.2188128018315;4596.747178905192;4603.608693261111;4625.606823419979;5581.302337207849;5605.271314729141;5623.6906970116215;5624.156376543633;5628.296462942132;5396.9730151348995;5407.675539467645;5411.350637923317;5420.268263784339;5463.863403414946;5479.315085614298;5524.779008839601;5581.888362232651;5618.831435056954;5657.773689052392;5323.228131920927;5367.1680889462195;5370.677759334452;5373.623846330719;5394.676319420847;5442.918356224581;5450.209719590716;5464.3442786865835;5467.589930755289;5489.725513724218;5203.505666961632;5208.687478751287;5334.279872217201;5350.170723537858;5413.648112872808;5280.498352656491;5285.524302812765;5286.920696189483;5297.549708274686;5299.682019078868;5082.872928176826;5177.508136727005;5178.0679477694375;5188.040212560688;5237.135872581134;5159.17453207485;5314.256004159343;5338.519533242027;5401.891962160814;5405.675659460445;5186.766595503287;5206.245094461357;5207.3230480037355;5208.895822083613;5214.983078299847 14:23:46 INFO - PROCESS | 5536 | |1;ext.html;536.6833568194766;539.1992890557522;561.99719001405;563.8618538458078;584.6901142394527;28870.56694149587;29243.122706318816;29252.414951700954;36450.45324320131;37016.259674806555;40204.99487512813;40687.18625627493;40712.79643601778;40725;40740.59259407405;8344.290735287508;8550.01674807399;8550.315974722038;8552.78618034551;8552.828943421127;8242.340612750995;8370.037445693732;8380.8742868857;8384.664613415456;8396.748097557083;8571.614277357503;8648;8667.17661822129;8668.8699669505;8669.21977022068;8489.40574159806;8562.272206862424;8564.785880352978;8578.613962371739;8579.14208579137;8367.497950123012;8622.611982460805;8630.180132887366;8632.093630168805;8634;40210;40879.1824163518;40930.386044209066;40961.26542284083;41058.38412423816;3277.655846136169;3280.311134661724;3345.7787907413863;3427.2288735034667;3790.9431358529646;27208.863955680095;29390.265243369086;29428;29496.705032949823;29506.55740163899;3907.1990242000606;3976.642102210786;4038.414429907647;4040.6969477289026;4193.412922190896;276150;277733;277945;277971;277990;55219.44780552143;55234.447655523734;55372.44627553673;55386.72306638522;55493.16760248599;65275.67362163254;65459;65459.34540654628;65505.67247163829;65515.34484655092;14881.702365952837;15044;15063.322150503254;15071.698566028617;15110.924445377923;11510.654680359603;11666;11673.88326116745;11687;11716.765664686658;19157.904210478857;20279.391618251477;20499.590008199753;20588.176472941213;20654.277100301417;6704.631245281459;7851.803704907423;8059.919400805917;8218.260356567938;8262.876056859152;889.3107841422949;945.3429866243033;955.9617615295449;1042.2495803021811;1094.6223552874246;27006.32484187911;27074.187774366408;27160.1851944442;27396.45207095847;27501.724982749918;1065.3448129400363;1105.7346236903086;1126.312949101064;1148.2249481599886;1192.076140990739;14745.434930672584;14961.015593762364;15099.849001509845;15215.391384344503;15319.770203446957;329935;333560;334021;334195;334459;44009.77995110004;44822.32766508505;52277.7386113067;52820.73589632027;52832.47167528275;1306.1118439461256;1334.1861464506644;1347.158026233604;1353.472145863114;1354.3769865861616;26494.205173844817;27380.863095684395;29225.561616576193;30629.771939753104;32728.67271327256;43731.78134109309;43788.781056094514;48819.26771098365;49677.751611241714;50585.747071264406;320559;320685;321246;322457;322675;41401.37897931473;41966.370504441846;42569.148617028106;42640;42691;38550.80724596359;39078.80460597679;39127;39242.411363830135;39625;33519.664803351654;33612.833392359884;33626;33664.49503257502;36329.27341453209;35363.823180883934;35865.28269434544;35964.46053309255;36214.63785362113;36261.81869090637;35335.82332088426;35670.64329356777;35848.82075589606;36137.457938131476;36138;30605;31638.841805790824;32879.67120328862;32906.50640240446;32924.835375823925;24822.751772482043;25106;25110.874445627654;25219.923888721096;25585.616215756407 14:23:46 INFO - PROCESS | 5536 | |2;jquery.html;369.66729943051234;369.9038250054987;369.90567405311646;372.071681155517;376.02984300504664;13772.173669579832;14462.638434039154;15877.206139693013;17751.911240443795;18685.252589896405;16475.44630582259;16671.41650042249;17178.656426871454;17420.738688919646;17490.21294041768;5271.815486457975;5353.411124776271;5418.83743487696;5422.864428389283;5431.83704488866;3952.2688302663955;4090.1819636072755;4093.7339072960312;4103.2409004334295;5330;5606.775728970836;5639.069553523664;5809;5814.5057670098095;5815.505682017012;5903;5939.049752039696;5943.078822782497;5943.959807033773;5947.345791962881;5119;5171.327727395452;5221.817236396746;5222.138347172712;5261.473852614746;20195.899020504803;20256.898715506475;20482.5903481931;20501.8974905126;20649.380518584316;2180.4766855954617;2203.46015226269;2360.221127028077;2371.0989823866994;2648.735126487355;6702.061711360365;12297.954673852733;12428.62714118578;12826.871731282754;13098.934505327412;1856.9071546422624;1864.7575815143944;1886.7075603281514;1886.7452893859427;1893.3657224829699;56328;56571.43428565703;56941.43058569403;57840.71079644617;58154.83690326212;9738.90261097394;9896.65361712351;9972;10028.247881408777;10058.647947321808;13158;13206.27365494907;13234.73530529384;13252.337383130805;13268.73462530744;7372.373348265458;7448.702051917971;7520.398368130536;7568.697252109964;7570.924290757132;7140.250273721288;7165.104361954755;7177.138743350727;7199.3520583147765;7217.458690598121;5882.529397648178;5989.880202395928;5997.790077347272;5999.730012149464;6015.939840601538;1682.6298214392814;1747.3010795681828;1754.3070487157502;1795.8114397988284;1816.5004623728316;895.2614093372994;900.6037343568809;937.6296362936602;971.5142428785607;1022.9259277758324;12780.872191278155;15355.692886142215;15755.68488630221;15913.443029493912;16648.417305394494;904.1817155474306;921.999630401009;927.2026057590467;949;995.6764051683232;8717.520536370434;8922.330825188006;9103.49930753815;9151.405158664798;9207.125323094295;477558;480659;483834;484334;487077;73758;74029.25970740331;74202;77066.61466692743;77258.61370693111;1003.9899601003897;1032.230987914009;1158.7740390623746;1168.9590864319878;1175.482787573465;14283.785743214068;15073.164928421407;15679.294431750826;15707.293171807525;15766.132862692662;31329.53005704962;34263.486047709805;34325.65674343325;35074;35804.28391432209;36889.44665830069;42839.78580107079;43403.34894976641;43528.78235608801;45018.77490612526;6936.479764017819;6963.721451141898;7009.754658586925;7083.858322833411;7343.192248852729;10240.231982601186;10734.946325268324;10753.193510486588;11136.443177841238;11366.261193022427;9234.30742694314;9249.907500925174;9553.140217380469;9735.26985476078;9815.312928094965;9342.205912497513;9447.385919915183;9511.476868772284;9861.063198996084;10134;9148.496832674267;9692.854607180758;9846.753831154278;10420.895791041992;10501.159907207253;7297.051383320135;7391.2239214881665;7460.142083660448;7476.887846682413;7551.093868735787;8621.956890215508;9053.954730226307;9737.756556085871;9854.26093043039;10215.387076775418 14:23:46 INFO - PROCESS | 5536 | |3;mootools.html;1336.5656161747422;1408.5281430720709;1456.0462896802594;1596.9281382337795;1784.6341499992502;6821.488388370867;7580.620968951551;7724.382049436045;7735;7743.690252389898;7428.777136685894;7584.696612135522;7597.506162099474;7606.505577137482;7609.54342739436;1997.950051248716;2045.1308194017558;2048.2216757632077;2281.4866655002616;2311.537692461506;2319.3969567912295;2375.596148654733;2381.9642705359433;2382.392489915078;2384.6065399209197;2294.6902168207243;2321.3732292281074;2323.0939933425975;2323.9186628468005;2343.9062437502566;2307.284741730061;2322.3729593009875;2329.767023297665;2343.695319608457;2347.401412639766;2262.061244583496;2267.8299127565497;2285.691431656738;2286.0512887151813;2288.302067869299;7808.687652493893;7899.407544434191;7904.051513818321;7910.485818421784;7916.6833326666865;4844.467108618049;4959.355283813117;4960.33035540201;4964.726940018298;4967.180415231519;3173.4922412413903;3196.6643502432144;3249.252671885456;3349.413852575814;3363.9495407568907;1085.5494969587612;1094.261373572843;1102.735343517558;1112.3548341961723;1128.1651577832426;10794.622188223453;10810.945945270301;10832.458377081115;10839.620613278497;10855.557499562614;4364.323529852814;4423.424954755861;4424.778761061934;4473.619742321939;4480.439945006874;9345.579448924678;9356.34505584616;9367.297452691075;9374;9380.24958003358;4885.462599114095;4890.364252647133;4907.190313598217;4920.581750551243;4922.040202160616;4409.977950110229;4421.270490369053;4443.933340999887;4452.866414007585;4467.508574056851;3508.6666766657127;3573.2496175802853;3724.1248306647917;3725.3108174987715;3807.1433927366675;1233.8457692788402;1236.771197328497;1242.6520574239228;1252.9122961392616;1255.8430196225472;1282.7562763074986;1319.9076064675573;1321.7951217561294;1349.9055066145472;1369.2879702554617;7238.203797582261;7369.963150184322;7372.299631534996;7374.557526548424;7375.778726638209;1112.9888701112886;1122.9494672739747;1132.377192544114;1135.1599816136;1144.2733863996423;5847.502962248172;5939.406059394026;5941.673207973603;5951.196588460502;5959.135925290809;9054.411463254868;9151.954240228757;9194.540272986324;9303.116203960613;9305.581248843819;9161.358704890594;9185.402948808307;9190.172884440433;9194.494302813277;9212.447253164832;7214.6031968241205;7318.377937875233;7359.595222262827;7396.704131834774;7411.4070874331;7327.157376901511;7406.814829629302;7407.074115735533;7410.703571857281;7411.851762964603;8033.397495188001;8140.389470789596;8285.62714677853;8401.70594029206;8427.157284271523;8346.374021948257;8349.373796965374;8383.790405239917;8497.57512124379;8529.616167272612;6970.616616086164;7120.145582530129;7123.038389817309;7124.430045596237;7128.073350464407;6678.83302917431;6835.213950395768;7133.500654954103;7300;7435.7025718970635;6824.5564038339335;6881.483888708467;6912.44700423975;6974.6512674367095;7035.6833942471685;6798.456123510206;6875.449964002968;6878.759243426456;6956.513044086865;6973.7210511581;6907.6891539879825;6955.408790252683;6962.860742785015;6962.895556566555;6963.442924566124;6319.52603554726;6375.489960803032;6442.130312407952;6535.869282614416;6556;6605.438537724347;6621.106150669598;6651;6656.434203092791;6666.566673166229 14:23:46 INFO - PROCESS | 5536 | |4;prototype.html;342.965703429657;346.30565715739937;348.7767828589703;350.49878673496903;350.65635677036494;5683.772649094041;5796.362400135987;5841.123831425289;5841.64950102993;5842.649441033535;5565;5707.828765137042;5730.598858079936;5746.051901436268;5751.56863235257;4526.66050046247;4527.253003254459;4531.864044078667;4533.662569541993;4537.342085397632;4299.50555686097;4389.18800021997;4423.402840616508;4501.7524036178;4522.3894774205555;4480.6191473724775;4481.731096134243;4486.102779444124;4490.910181796362;4515.887102822439;4479.574440428154;4492.2812350024005;4495.370648109268;4498.077894031716;4503.752293623849;4013.6387725104883;4014.096828213658;4016.2971479990883;4017.3773065174946;4020.537638171589;5406.351237851443;5540.390557038722;5544.029794785896;5548.944510554883;5551.528120109796;5104.336436263299;5115.669925819277;5116.2069879168785;5119.283300337956;5182.922256166161;5810.88378232433;6125.785597504066;6126.785562505335;6139.877202455926;6148.907766383508;4139.4204811326435;4221.2190744712325;4270.338097594878;4285.035866929947;4294.849680261207;6276.089966954812;6321.367863213688;6351.491880649537;6356.555041147121;6365.3634636536435;4416.271315233015;4417.558244175557;4417.8232870684815;4419.64642828573;4426.623736982393;4355.651547876162;4475.4181956345465;4480.596746292849;4485.730856148642;4488.192125417456;5142.202958541432;5159.58723302135;5162.174052151638;5165.1219292720325;5166.070107380632;6136.23297087864;6147.631142131487;6157.72290246931;6159.599626024294;6160.075988601656;1567.2242240091227;1591.0294720220656;1591.053323272651;1591.9602009949613;1592.283472437408;1048.1771809129796;1050.81610718124;1064.3401091323428;1073.2487258918788;1076.6931424543968;5806.0129777937855;5810.767569297265;5819.883602328015;5831.271091113526;5835.883282334329;6310.968445157745;6332.1135041094285;6400.07198956158;6401.199850018747;6404.327545607644;5811.593188476766;5812.738426770806;5813.3895940925595;5814.215080964016;5818.272715910512;3303.438415469376;3403.931921361559;3410.6418826023405;3411.2154204533094;3416.5046068320453;6551.181102362205;6562.146920900253;6570.277269500351;6575.276719560845;6575.835604109936;6456.612603243821;6457.063725759833;6464.256610489854;6469.061986012096;6471.546991710535;6378.043293505918;6541.738330466823;6559.770408035696;6599.8020059398295;6623.337666233435;6076.179715738319;6249.0626406039455;6294.496440284858;6299.811005669837;6302.086197501245;6103.7558497661375;6214.8135555933395;6242.28213755424;6280.466160376419;6285.088662144055;6585.407313341822;6590.637514936724;6590.901136483052;6605.5376123670885;6642.136522252076;4382;4478.865634030984;4479;4479.7536135512855;4479.843205487792;6353.809385718436;6364.681765911779;6365.045243213555;6365.172527571386;6373.968130159319;6255;6262.15460912771;6265.342139075331;6270.529710271839;6272.780452684134;5985.1022346646605;6153.384661533811;6169.784057557964;6172.660503672341;6181.350958149509;6011.038233882733;6057.303410107894;6058.303295120942;6066.514678825772;6070.392960704071;6228.781992630236;6229.96885015572;6232.75068997235;6235.033569796688;6241.063840423791;5918.970405147947;6044.576879618385;6060.818175454743;6066.211392518944;6091.238595175603 14:23:46 INFO - PROCESS | 5536 | |5;yui.html;727.8617062758076;752.086215248473;798.7164556582413;856.7643897928065;873.5326600268853;13949.442022319108;14173.291335433212;14178.645533861658;14179.291035448225;14227;12748.745025099515;13072.346382680875;13092.279924604143;13112.475500979974;13772.93113534431;810.5866008335732;822.4941660878546;824.2622852546997;824.4435006370705;824.7443292579289;830.2652152844715;833.125218520551;835.2190701693905;835.2900034970257;836.3810780022769;866.8699695045731;868.1665601023026;868.2533021601449;868.9695860644879;873.9825203495926;864.0538610221797;864.5115509736978;864.8356812205661;867.7179916527123;875.2822685397977;636.8535236895493;637.1239545624766;638.0174531221912;638.4445532386807;641.8940874755659;12844.293563853984;12887.226766394046;12899.67750806228;12944;12957.870421295855;11357.659270221906;11412.20114591979;11447.683516395555;11500.94249528747;11797.705057373549;9732.464714440703;9750.561224744904;9788.265880058952;9910.20718342531;9974.451405172713;3511.20997775501;3585.515955346021;3591.910202244939;3626.0209743369405;3682.429223470366;44018.33972490415;45066.77466612646;46128;50421.24368134481;56091.43908560903;10597.20520960931;10761.30051546647;10801.621943231949;10854.565817367216;10878.782424351468;18755.968421736936;18792.436226913214;18793.624127517374;18794.718079228824;18859.434216973514;7850.371970242367;7952.880706789403;7976.920230797734;8097.838043239102;8216.507009579444;4552.6813123081065;4576.81692732287;4630.837920672828;4727.929081063787;4754.049190161982;3088.7528997680133;3097.3495565931407;3114.1903105192814;3116.2209447638093;3120.095172400024;566.5043087298614;577.1314172170856;580.0342429854329;580.3876909860138;590.3388205210106;512.1140427061131;569.8603842058723;599.7241269016301;704.3766266853769;708.6067232685806;8698.956505217433;8766.780830479289;8924.509151996703;8992.145746154105;9004;567.9943200567941;578.467809615155;648.7145655911384;663.6383171171723;684.44901854007;4026.255142798592;4086.5504794472586;4214.452121224222;4223.640990515779;4226.420332026317;52788.736056319474;54444.45555544473;54517.454825452034;54999;55004.449955500735;46200.3069953951;48674.51325486771;48786;48858.75570622124;50675;40593.797031015245;43455.56544434515;44096.11807763891;44119.33820992688;45225.54774452213;8847.557622118997;9069.455832650063;9138.223251023737;9153.130452606993;9193.448393096436;29911.401771964003;30414.84792576023;34410.13974650654;34866.82566587151;35169.29661406706;41823.58176418319;47782.283265750346;47942.52057479381;48914.26628600645;49384;11372.943135284271;11439.542418303508;11599.76800464003;11649.48608147757;11746.119041072125;11317.547298107984;11343;11683.941580292045;12061.577844775391;12354.814677779661;11348.002436596373;12037.819432708342;12170.57402990891;12528.436220369922;12570.245785252913;11771.764564708828;12247.693807654523;12549.247045176953;12647.430865611253;12665.113442058968;11484.483198255932;11638.24351417189;11975.880241197476;12338.13633045714;12383.69040773988;9580.856287155837;9867.506624668882;9912.801743964936;10074.748131296776;10224.130948869131;9500.61997520119;9734.172595329477;9834.164096051629;10228.64199753005;10407.895921040692 14:23:46 INFO - PROCESS | 5536 | __end_tp_report 14:23:46 INFO - PROCESS | 5536 | __start_cc_report 14:23:46 INFO - PROCESS | 5536 | _x_x_mozilla_cycle_collect,681 14:23:46 INFO - PROCESS | 5536 | __end_cc_report 14:23:46 INFO - PROCESS | 5536 | __startTimestamp1453155826942__endTimestamp 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | ------- Summary: start ------- 14:23:46 INFO - PROCESS | 5536 | Number of tests: 6 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#0] dojo.html Cycles:165 Average:5026.29 Median:5203.51 stddev:539.15 (10.4%) stddev-sans-first:519.47 14:23:46 INFO - PROCESS | 5536 | Values: 3112.1 3118.0 3164.8 3166.0 3188.2 4941.9 5000.3 5015.4 5042.6 5079.6 5032.2 5071.3 5072.9 5077.7 5086.3 4406.6 4569.2 4578.1 4629.3 4721.2 4491.7 4635.3 4670.2 4679.1 4712.6 4522.0 4551.5 4596.4 4610.0 4628.2 4574.2 4574.7 4576.5 4585.8 4609.8 4558.0 4576.8 4578.6 4610.4 4611.6 4815.5 4821.3 4864.8 4889.8 4910.4 5402.1 5426.7 5436.6 5445.0 5451.7 5370.0 5470.9 5478.7 5482.9 5535.6 4996.3 5038.1 5083.5 5126.2 5127.7 5559.8 5581.6 5594.7 5597.1 5648.9 5245.7 5385.8 5394.4 5396.1 5399.8 5331.2 5360.7 5364.4 5415.9 5436.1 5355.0 5368.1 5371.6 5376.0 5378.0 5198.7 5305.4 5380.9 5391.4 5427.0 4206.4 4213.6 4222.3 4224.9 4253.5 3796.6 3799.4 3810.9 3816.6 3838.2 4981.0 5002.2 5059.3 5065.9 5084.3 5361.6 5371.1 5401.8 5410.1 5452.6 4958.4 4966.8 4967.3 4974.6 5017.3 4558.3 4595.2 4596.7 4603.6 4625.6 5581.3 5605.3 5623.7 5624.2 5628.3 5397.0 5407.7 5411.4 5420.3 5463.9 5479.3 5524.8 5581.9 5618.8 5657.8 5323.2 5367.2 5370.7 5373.6 5394.7 5442.9 5450.2 5464.3 5467.6 5489.7 5203.5 5208.7 5334.3 5350.2 5413.6 5280.5 5285.5 5286.9 5297.5 5299.7 5082.9 5177.5 5178.1 5188.0 5237.1 5159.2 5314.3 5338.5 5401.9 5405.7 5186.8 5206.2 5207.3 5208.9 5215.0 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#1] ext.html Cycles:180 Average:47707.02 Median:36176.32 stddev:81633.49 (225.7%) stddev-sans-first:81785.67 14:23:46 INFO - PROCESS | 5536 | Values: 536.7 539.2 562.0 563.9 584.7 28870.6 29243.1 29252.4 36450.5 37016.3 40205.0 40687.2 40712.8 40725.0 40740.6 8344.3 8550.0 8550.3 8552.8 8552.8 8242.3 8370.0 8380.9 8384.7 8396.7 8571.6 8648.0 8667.2 8668.9 8669.2 8489.4 8562.3 8564.8 8578.6 8579.1 8367.5 8622.6 8630.2 8632.1 8634.0 40210.0 40879.2 40930.4 40961.3 41058.4 3277.7 3280.3 3345.8 3427.2 3790.9 27208.9 29390.3 29428.0 29496.7 29506.6 3907.2 3976.6 4038.4 4040.7 4193.4 276150.0 277733.0 277945.0 277971.0 277990.0 55219.4 55234.4 55372.4 55386.7 55493.2 65275.7 65459.0 65459.3 65505.7 65515.3 14881.7 15044.0 15063.3 15071.7 15110.9 11510.7 11666.0 11673.9 11687.0 11716.8 19157.9 20279.4 20499.6 20588.2 20654.3 6704.6 7851.8 8059.9 8218.3 8262.9 889.3 945.3 956.0 1042.2 1094.6 27006.3 27074.2 27160.2 27396.5 27501.7 1065.3 1105.7 1126.3 1148.2 1192.1 14745.4 14961.0 15099.8 15215.4 15319.8 329935.0 333560.0 334021.0 334195.0 334459.0 44009.8 44822.3 52277.7 52820.7 52832.5 1306.1 1334.2 1347.2 1353.5 1354.4 26494.2 27380.9 29225.6 30629.8 32728.7 43731.8 43788.8 48819.3 49677.8 50585.7 320559.0 320685.0 321246.0 322457.0 322675.0 41401.4 41966.4 42569.1 42640.0 42691.0 38550.8 39078.8 39127.0 39242.4 39625.0 33519.7 33612.8 33626.0 33664.5 36329.3 35363.8 35865.3 35964.5 36214.6 36261.8 35335.8 35670.6 35848.8 36137.5 36138.0 30605.0 31638.8 32879.7 32906.5 32924.8 24822.8 25106.0 25110.9 25219.9 25585.6 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#2] jquery.html Cycles:180 Average:26109.90 Median:5145.16 stddev:78959.15 (1534.6%) stddev-sans-first:79156.99 14:23:46 INFO - PROCESS | 5536 | Values: 369.7 369.9 369.9 372.1 376.0 13772.2 14462.6 15877.2 17751.9 18685.3 16475.4 16671.4 17178.7 17420.7 17490.2 5271.8 5353.4 5418.8 5422.9 5431.8 3952.3 4090.2 4093.7 4103.2 5330.0 5606.8 5639.1 5809.0 5814.5 5815.5 5903.0 5939.0 5943.1 5944.0 5947.3 5119.0 5171.3 5221.8 5222.1 5261.5 20195.9 20256.9 20482.6 20501.9 20649.4 2180.5 2203.5 2360.2 2371.1 2648.7 6702.1 12298.0 12428.6 12826.9 13098.9 1856.9 1864.8 1886.7 1886.7 1893.4 56328.0 56571.4 56941.4 57840.7 58154.8 9738.9 9896.7 9972.0 10028.2 10058.6 13158.0 13206.3 13234.7 13252.3 13268.7 7372.4 7448.7 7520.4 7568.7 7570.9 7140.3 7165.1 7177.1 7199.4 7217.5 5882.5 5989.9 5997.8 5999.7 6015.9 1682.6 1747.3 1754.3 1795.8 1816.5 895.3 900.6 937.6 971.5 1022.9 12780.9 15355.7 15755.7 15913.4 16648.4 904.2 922.0 927.2 949.0 995.7 8717.5 8922.3 9103.5 9151.4 9207.1 477558.0 480659.0 483834.0 484334.0 487077.0 73758.0 74029.3 74202.0 77066.6 77258.6 1004.0 1032.2 1158.8 1169.0 1175.5 14283.8 15073.2 15679.3 15707.3 15766.1 31329.5 34263.5 34325.7 35074.0 35804.3 36889.4 42839.8 43403.3 43528.8 45018.8 6936.5 6963.7 7009.8 7083.9 7343.2 10240.2 10734.9 10753.2 11136.4 11366.3 9234.3 9249.9 9553.1 9735.3 9815.3 9342.2 9447.4 9511.5 9861.1 10134.0 9148.5 9692.9 9846.8 10420.9 10501.2 7297.1 7391.2 7460.1 7476.9 7551.1 8622.0 9054.0 9737.8 9854.3 10215.4 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#3] mootools.html Cycles:180 Average:5491.13 Median:6347.51 stddev:2785.38 (43.9%) stddev-sans-first:2775.69 14:23:46 INFO - PROCESS | 5536 | Values: 1336.6 1408.5 1456.0 1596.9 1784.6 6821.5 7580.6 7724.4 7735.0 7743.7 7428.8 7584.7 7597.5 7606.5 7609.5 1998.0 2045.1 2048.2 2281.5 2311.5 2319.4 2375.6 2382.0 2382.4 2384.6 2294.7 2321.4 2323.1 2323.9 2343.9 2307.3 2322.4 2329.8 2343.7 2347.4 2262.1 2267.8 2285.7 2286.1 2288.3 7808.7 7899.4 7904.1 7910.5 7916.7 4844.5 4959.4 4960.3 4964.7 4967.2 3173.5 3196.7 3249.3 3349.4 3363.9 1085.5 1094.3 1102.7 1112.4 1128.2 10794.6 10810.9 10832.5 10839.6 10855.6 4364.3 4423.4 4424.8 4473.6 4480.4 9345.6 9356.3 9367.3 9374.0 9380.2 4885.5 4890.4 4907.2 4920.6 4922.0 4410.0 4421.3 4443.9 4452.9 4467.5 3508.7 3573.2 3724.1 3725.3 3807.1 1233.8 1236.8 1242.7 1252.9 1255.8 1282.8 1319.9 1321.8 1349.9 1369.3 7238.2 7370.0 7372.3 7374.6 7375.8 1113.0 1122.9 1132.4 1135.2 1144.3 5847.5 5939.4 5941.7 5951.2 5959.1 9054.4 9152.0 9194.5 9303.1 9305.6 9161.4 9185.4 9190.2 9194.5 9212.4 7214.6 7318.4 7359.6 7396.7 7411.4 7327.2 7406.8 7407.1 7410.7 7411.9 8033.4 8140.4 8285.6 8401.7 8427.2 8346.4 8349.4 8383.8 8497.6 8529.6 6970.6 7120.1 7123.0 7124.4 7128.1 6678.8 6835.2 7133.5 7300.0 7435.7 6824.6 6881.5 6912.4 6974.7 7035.7 6798.5 6875.4 6878.8 6956.5 6973.7 6907.7 6955.4 6962.9 6962.9 6963.4 6319.5 6375.5 6442.1 6535.9 6556.0 6605.4 6621.1 6651.0 6656.4 6666.6 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#4] prototype.html Cycles:180 Average:5153.37 Median:5812.17 stddev:1532.67 (26.4%) stddev-sans-first:1493.84 14:23:46 INFO - PROCESS | 5536 | Values: 343.0 346.3 348.8 350.5 350.7 5683.8 5796.4 5841.1 5841.6 5842.6 5565.0 5707.8 5730.6 5746.1 5751.6 4526.7 4527.3 4531.9 4533.7 4537.3 4299.5 4389.2 4423.4 4501.8 4522.4 4480.6 4481.7 4486.1 4490.9 4515.9 4479.6 4492.3 4495.4 4498.1 4503.8 4013.6 4014.1 4016.3 4017.4 4020.5 5406.4 5540.4 5544.0 5548.9 5551.5 5104.3 5115.7 5116.2 5119.3 5182.9 5810.9 6125.8 6126.8 6139.9 6148.9 4139.4 4221.2 4270.3 4285.0 4294.8 6276.1 6321.4 6351.5 6356.6 6365.4 4416.3 4417.6 4417.8 4419.6 4426.6 4355.7 4475.4 4480.6 4485.7 4488.2 5142.2 5159.6 5162.2 5165.1 5166.1 6136.2 6147.6 6157.7 6159.6 6160.1 1567.2 1591.0 1591.1 1592.0 1592.3 1048.2 1050.8 1064.3 1073.2 1076.7 5806.0 5810.8 5819.9 5831.3 5835.9 6311.0 6332.1 6400.1 6401.2 6404.3 5811.6 5812.7 5813.4 5814.2 5818.3 3303.4 3403.9 3410.6 3411.2 3416.5 6551.2 6562.1 6570.3 6575.3 6575.8 6456.6 6457.1 6464.3 6469.1 6471.5 6378.0 6541.7 6559.8 6599.8 6623.3 6076.2 6249.1 6294.5 6299.8 6302.1 6103.8 6214.8 6242.3 6280.5 6285.1 6585.4 6590.6 6590.9 6605.5 6642.1 4382.0 4478.9 4479.0 4479.8 4479.8 6353.8 6364.7 6365.0 6365.2 6374.0 6255.0 6262.2 6265.3 6270.5 6272.8 5985.1 6153.4 6169.8 6172.7 6181.4 6011.0 6057.3 6058.3 6066.5 6070.4 6228.8 6230.0 6232.8 6235.0 6241.1 5919.0 6044.6 6060.8 6066.2 6091.2 14:23:46 INFO - PROCESS | 5536 | 14:23:46 INFO - PROCESS | 5536 | [#5] yui.html Cycles:180 Average:13718.92 Median:25415.57 stddev:15468.76 (60.9%) stddev-sans-first:15481.39 14:23:46 INFO - PROCESS | 5536 | Values: 727.9 752.1 798.7 856.8 873.5 13949.4 14173.3 14178.6 14179.3 14227.0 12748.7 13072.3 13092.3 13112.5 13772.9 810.6 822.5 824.3 824.4 824.7 830.3 833.1 835.2 835.3 836.4 866.9 868.2 868.3 869.0 874.0 864.1 864.5 864.8 867.7 875.3 636.9 637.1 638.0 638.4 641.9 12844.3 12887.2 12899.7 12944.0 12957.9 11357.7 11412.2 11447.7 11500.9 11797.7 9732.5 9750.6 9788.3 9910.2 9974.5 3511.2 3585.5 3591.9 3626.0 3682.4 44018.3 45066.8 46128.0 50421.2 56091.4 10597.2 10761.3 10801.6 10854.6 10878.8 18756.0 18792.4 18793.6 18794.7 18859.4 7850.4 7952.9 7976.9 8097.8 8216.5 4552.7 4576.8 4630.8 4727.9 4754.0 3088.8 3097.3 3114.2 3116.2 3120.1 566.5 577.1 580.0 580.4 590.3 512.1 569.9 599.7 704.4 708.6 8699.0 8766.8 8924.5 8992.1 9004.0 568.0 578.5 648.7 663.6 684.4 4026.3 4086.6 4214.5 4223.6 4226.4 52788.7 54444.5 54517.5 54999.0 55004.4 46200.3 48674.5 48786.0 48858.8 50675.0 40593.8 43455.6 44096.1 44119.3 45225.5 8847.6 9069.5 9138.2 9153.1 9193.4 29911.4 30414.8 34410.1 34866.8 35169.3 41823.6 47782.3 47942.5 48914.3 49384.0 11372.9 11439.5 11599.8 11649.5 11746.1 11317.5 11343.0 11683.9 12061.6 12354.8 11348.0 12037.8 12170.6 12528.4 12570.2 11771.8 12247.7 12549.2 12647.4 12665.1 11484.5 11638.2 11975.9 12338.1 12383.7 9580.9 9867.5 9912.8 10074.7 10224.1 9500.6 9734.2 9834.2 10228.6 10407.9 14:23:46 INFO - PROCESS | 5536 | -------- Summary: end -------- 14:23:46 INFO - PROCESS | 5536 | 14:23:47 INFO - TEST-INFO | 5536: exit 0 14:23:47 INFO - TEST-OK | dromaeo_css | took 1111976ms 14:23:47 INFO - TEST-START | kraken 14:23:47 INFO - operating with platform_type : linux_ 14:23:47 INFO - Initialising browser for kraken test... 14:23:47 INFO - TEST-INFO | started process 5741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw1P5TY/profile http://localhost:33657/getInfo.html) 14:23:51 INFO - PROCESS | 5741 | __metrics Screen width/height:1600/1200 14:23:51 INFO - PROCESS | 5741 | colorDepth:24 14:23:51 INFO - PROCESS | 5741 | Browser inner width/height: 1024/697 14:23:51 INFO - PROCESS | 5741 | __metrics 14:23:51 INFO - PROCESS | 5741 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:51 INFO - PROCESS | 5741 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:52 INFO - TEST-INFO | 5741: exit 0 14:23:52 INFO - Browser initialized. 14:23:52 INFO - Running cycle 1/1 for kraken test... 14:23:52 INFO - TEST-INFO | started process 5822 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw1P5TY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:04 INFO - PROCESS | 5822 | RSS: Main: 149880832 14:24:04 INFO - PROCESS | 5822 | 14:24:07 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33657/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:07 INFO - PROCESS | 5822 | RSS: Main: 187879424 14:24:07 INFO - PROCESS | 5822 | 14:24:10 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33657/tests/kraken/driver.html?testName=audio-dft) 14:24:10 INFO - PROCESS | 5822 | RSS: Main: 177352704 14:24:10 INFO - PROCESS | 5822 | 14:24:13 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33657/tests/kraken/driver.html?testName=audio-fft) 14:24:14 INFO - PROCESS | 5822 | RSS: Main: 161439744 14:24:14 INFO - PROCESS | 5822 | 14:24:16 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33657/tests/kraken/driver.html?testName=audio-oscillator) 14:24:16 INFO - PROCESS | 5822 | RSS: Main: 164491264 14:24:16 INFO - PROCESS | 5822 | 14:24:19 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:19 INFO - PROCESS | 5822 | RSS: Main: 165191680 14:24:19 INFO - PROCESS | 5822 | 14:24:22 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33657/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:23 INFO - PROCESS | 5822 | RSS: Main: 165986304 14:24:23 INFO - PROCESS | 5822 | 14:24:26 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33657/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:27 INFO - PROCESS | 5822 | RSS: Main: 167583744 14:24:27 INFO - PROCESS | 5822 | 14:24:29 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33657/tests/kraken/driver.html?testName=json-parse-financial) 14:24:30 INFO - PROCESS | 5822 | RSS: Main: 167301120 14:24:30 INFO - PROCESS | 5822 | 14:24:32 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:32 INFO - PROCESS | 5822 | RSS: Main: 181927936 14:24:32 INFO - PROCESS | 5822 | 14:24:34 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:34 INFO - PROCESS | 5822 | RSS: Main: 180817920 14:24:34 INFO - PROCESS | 5822 | 14:24:37 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:37 INFO - PROCESS | 5822 | RSS: Main: 191037440 14:24:37 INFO - PROCESS | 5822 | 14:24:40 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:24:40 INFO - PROCESS | 5822 | RSS: Main: 196521984 14:24:40 INFO - PROCESS | 5822 | 14:24:43 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:43 INFO - PROCESS | 5822 | RSS: Main: 194215936 14:24:43 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | Cycle 1(1): loaded http://localhost:33657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33657/tests/kraken/driver.html?testName=ai-astar) 14:24:45 INFO - PROCESS | 5822 | RSS: Main: 252887040 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | __start_tp_report 14:24:45 INFO - PROCESS | 5822 | _x_x_mozilla_page_load 14:24:45 INFO - PROCESS | 5822 | _x_x_mozilla_page_load_details 14:24:45 INFO - PROCESS | 5822 | |i|pagename|runs| 14:24:45 INFO - PROCESS | 5822 | |0;ai-astar;109;110;105;110;110;110;111;111;103;110 14:24:45 INFO - PROCESS | 5822 | |1;audio-beat-detection;148;127;150;163;128;153;151;128;164;123 14:24:45 INFO - PROCESS | 5822 | |2;audio-dft;162;162;161;160;160;161;160;161;162;163 14:24:45 INFO - PROCESS | 5822 | |3;audio-fft;71;73;93;101;75;73;72;122;101;71 14:24:45 INFO - PROCESS | 5822 | |4;audio-oscillator;98;96;142;95;97;95;143;96;96;136 14:24:45 INFO - PROCESS | 5822 | |5;imaging-gaussian-blur;108;110;109;109;109;110;110;109;108;108 14:24:45 INFO - PROCESS | 5822 | |6;imaging-darkroom;147;145;147;146;146;148;145;145;146;145 14:24:45 INFO - PROCESS | 5822 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;95;96 14:24:45 INFO - PROCESS | 5822 | |8;json-parse-financial;59;56;56;55;56;55;56;55;55;54 14:24:45 INFO - PROCESS | 5822 | |9;json-stringify-tinderbox;66;67;67;68;67;69;68;68;68;67 14:24:45 INFO - PROCESS | 5822 | |10;stanford-crypto-aes;81;81;81;81;82;90;82;84;83;83 14:24:45 INFO - PROCESS | 5822 | |11;stanford-crypto-ccm;122;114;115;120;120;117;117;112;120;128 14:24:45 INFO - PROCESS | 5822 | |12;stanford-crypto-pbkdf2;141;132;138;140;139;132;138;138;145;143 14:24:45 INFO - PROCESS | 5822 | |13;stanford-crypto-sha256-iterative;64;65;66;66;65;64;65;68;65;66 14:24:45 INFO - PROCESS | 5822 | __end_tp_report 14:24:45 INFO - PROCESS | 5822 | __start_cc_report 14:24:45 INFO - PROCESS | 5822 | _x_x_mozilla_cycle_collect,920 14:24:45 INFO - PROCESS | 5822 | __end_cc_report 14:24:45 INFO - PROCESS | 5822 | __startTimestamp1453155885584__endTimestamp 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | ------- Summary: start ------- 14:24:45 INFO - PROCESS | 5822 | Number of tests: 14 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.69 (2.4%) stddev-sans-first:2.85 14:24:45 INFO - PROCESS | 5822 | Values: 109.0 110.0 105.0 110.0 110.0 110.0 111.0 111.0 103.0 110.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:150.50 stddev:15.57 (10.3%) stddev-sans-first:16.43 14:24:45 INFO - PROCESS | 5822 | Values: 148.0 127.0 150.0 163.0 128.0 153.0 151.0 128.0 164.0 123.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 14:24:45 INFO - PROCESS | 5822 | Values: 162.0 162.0 161.0 160.0 160.0 161.0 160.0 161.0 162.0 163.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#3] audio-fft Cycles:10 Average:85.20 Median:72.50 stddev:17.93 (24.7%) stddev-sans-first:18.27 14:24:45 INFO - PROCESS | 5822 | Values: 71.0 73.0 93.0 101.0 75.0 73.0 72.0 122.0 101.0 71.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.44 (22.3%) stddev-sans-first:22.34 14:24:45 INFO - PROCESS | 5822 | Values: 98.0 96.0 142.0 95.0 97.0 95.0 143.0 96.0 96.0 136.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 14:24:45 INFO - PROCESS | 5822 | Values: 108.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 108.0 108.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 14:24:45 INFO - PROCESS | 5822 | Values: 147.0 145.0 147.0 146.0 146.0 148.0 145.0 145.0 146.0 145.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:24:45 INFO - PROCESS | 5822 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.34 (2.4%) stddev-sans-first:0.71 14:24:45 INFO - PROCESS | 5822 | Values: 59.0 56.0 56.0 55.0 56.0 55.0 56.0 55.0 55.0 54.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 14:24:45 INFO - PROCESS | 5822 | Values: 66.0 67.0 67.0 68.0 67.0 69.0 68.0 68.0 68.0 67.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.74 (3.3%) stddev-sans-first:2.83 14:24:45 INFO - PROCESS | 5822 | Values: 81.0 81.0 81.0 81.0 82.0 90.0 82.0 84.0 83.0 83.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:120.00 stddev:4.58 (3.8%) stddev-sans-first:4.68 14:24:45 INFO - PROCESS | 5822 | Values: 122.0 114.0 115.0 120.0 120.0 117.0 117.0 112.0 120.0 128.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:139.50 stddev:4.17 (3.0%) stddev-sans-first:4.33 14:24:45 INFO - PROCESS | 5822 | Values: 141.0 132.0 138.0 140.0 139.0 132.0 138.0 138.0 145.0 143.0 14:24:45 INFO - PROCESS | 5822 | 14:24:45 INFO - PROCESS | 5822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.17 (1.8%) stddev-sans-first:1.13 14:24:45 INFO - PROCESS | 5822 | Values: 64.0 65.0 66.0 66.0 65.0 64.0 65.0 68.0 65.0 66.0 14:24:45 INFO - PROCESS | 5822 | -------- Summary: end -------- 14:24:45 INFO - PROCESS | 5822 | 14:24:46 INFO - TEST-INFO | 5822: exit 0 14:24:46 INFO - TEST-OK | kraken | took 58879ms 14:24:46 INFO - TEST-START | v8_7 14:24:46 INFO - operating with platform_type : linux_ 14:24:46 INFO - Initialising browser for v8_7 test... 14:24:46 INFO - TEST-INFO | started process 6070 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCwY7XG/profile http://localhost:33657/getInfo.html) 14:24:50 INFO - PROCESS | 6070 | __metrics Screen width/height:1600/1200 14:24:50 INFO - PROCESS | 6070 | colorDepth:24 14:24:50 INFO - PROCESS | 6070 | Browser inner width/height: 1024/697 14:24:50 INFO - PROCESS | 6070 | __metrics 14:24:50 INFO - PROCESS | 6070 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:24:50 INFO - PROCESS | 6070 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:51 INFO - TEST-INFO | 6070: exit 0 14:24:51 INFO - Browser initialized. 14:24:51 INFO - Running cycle 1/1 for v8_7 test... 14:24:51 INFO - TEST-INFO | started process 6155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCwY7XG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:03 INFO - PROCESS | 6155 | RSS: Main: 149708800 14:25:03 INFO - PROCESS | 6155 | 14:25:25 INFO - PROCESS | 6155 | Cycle 1(1): loaded http://localhost:33657/tests/v8_7/run.html (next: http://localhost:33657/tests/v8_7/run.html) 14:25:26 INFO - PROCESS | 6155 | RSS: Main: 565223424 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | __start_tp_report 14:25:26 INFO - PROCESS | 6155 | _x_x_mozilla_page_load 14:25:26 INFO - PROCESS | 6155 | _x_x_mozilla_page_load_details 14:25:26 INFO - PROCESS | 6155 | |i|pagename|runs| 14:25:26 INFO - PROCESS | 6155 | |0;Richards;167.64459346186086 14:25:26 INFO - PROCESS | 6155 | |1;DeltaBlue;188.5014137606032 14:25:26 INFO - PROCESS | 6155 | |2;Encrypt;279.17364600781684 14:25:26 INFO - PROCESS | 6155 | |3;Decrypt;5148.717948717948 14:25:26 INFO - PROCESS | 6155 | |4;RayTrace;1257.861635220126 14:25:26 INFO - PROCESS | 6155 | |5;Earley;783.6990595611285 14:25:26 INFO - PROCESS | 6155 | |6;Boyer;12419.753086419752 14:25:26 INFO - PROCESS | 6155 | |7;RegExp;42729.166666666664 14:25:26 INFO - PROCESS | 6155 | |8;Splay;572.4098454493417 14:25:26 INFO - PROCESS | 6155 | |9;NavierStokes;4850.241545893719 14:25:26 INFO - PROCESS | 6155 | __end_tp_report 14:25:26 INFO - PROCESS | 6155 | __startTimestamp1453155926126__endTimestamp 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | ------- Summary: start ------- 14:25:26 INFO - PROCESS | 6155 | Number of tests: 10 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 167.6 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 188.5 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 279.2 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 5148.7 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#4] RayTrace Cycles:1 Average:1257.86 Median:1257.86 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 1257.9 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 783.7 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 12419.8 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 42729.2 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#8] Splay Cycles:1 Average:572.41 Median:572.41 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 572.4 14:25:26 INFO - PROCESS | 6155 | 14:25:26 INFO - PROCESS | 6155 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 14:25:26 INFO - PROCESS | 6155 | Values: 4850.2 14:25:26 INFO - PROCESS | 6155 | -------- Summary: end -------- 14:25:26 INFO - PROCESS | 6155 | 14:25:27 INFO - TEST-INFO | 6155: exit 0 14:25:27 INFO - TEST-OK | v8_7 | took 40535ms 14:25:27 INFO - SUITE-END | took 1211s 14:25:27 INFO - Completed test suite (00:20:11) 14:25:27 INFO - Working with test: dromaeo_css 14:25:27 INFO - Generating results file: dromaeo_css 14:25:27 INFO - Working with test: kraken 14:25:27 INFO - Generating results file: kraken 14:25:27 INFO - javascript benchmark 14:25:27 INFO - Working with test: v8_7 14:25:27 INFO - Generating results file: v8_7 14:25:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 14:25:27 INFO - process_Request line: dromaeo_css 6849.19 graph.html#tests=[[72,201,35]] 14:25:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:27 INFO - process_Request line: kraken 1487.50 graph.html#tests=[[232,201,35]] 14:25:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:27 INFO - process_Request line: v8_7 19869.34 graph.html#tests=[[230,201,35]] 14:25:27 INFO - RETURN: dromaeo_css: 6849.19 14:25:27 INFO - RETURN: kraken: 1487.50 14:25:27 INFO - RETURN: v8_7: 19869.34 14:25:27 INFO - javascript benchmark 14:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3112.0663800859743, 3117.984410077949, 3164.794288371256, 3165.9683403165964, 3188.2029492626843, 4941.851744447663, 5000.3499545059185, 5015.423226328973, 5042.571381432578, 5079.619028572858, 5032.245163225518, 5071.264666623347, 5072.898542029157, 5077.720725360104, 5086.313347698059, 4406.625436837857, 4569.200389931765, 4578.084383123381, 4629.305604159369, 4721.220998535255, 4491.663125265602, 4635.258358662614, 4670.229412146991, 4679.064187162564, 4712.6229901607785, 4521.999999999984, 4551.522090180533, 4596.448426188862, 4610.031893302411, 4628.1669299526075, 4574.153781550423, 4574.72551646899, 4576.519465456146, 4585.770711464447, 4609.815607375701, 4557.95442045582, 4576.794044268016, 4578.587927086545, 4610.446746390421, 4611.5619016193405, 4815.518448155157, 4821.252705830567, 4864.756762161877, 4889.779959901813, 4910.361652985089, 5402.054640437907, 5426.701531415771, 5436.592255580847, 5445.019896418643, 5451.700156491392, 5370.0, 5470.91793623096, 5478.671279723189, 5482.91775623366, 5535.58483113764, 4996.2505624156665, 5038.118329292359, 5083.466236045236, 5126.205438157129, 5127.692338459704, 5559.77760889568, 5581.5813813963305, 5594.748236329375, 5597.132444471114, 5648.915266271009, 5245.737713114329, 5385.8114965976, 5394.406615272317, 5396.055690254189, 5399.811006614828, 5331.226972089025, 5360.65155764874, 5364.436734142859, 5415.945840541623, 5436.130219164915, 5354.973225133849, 5368.0605893968395, 5371.57027437804, 5375.973120134452, 5378.044293286357, 5198.6880787152895, 5305.363356397257, 5380.892382152335, 5391.406945236021, 5427.023135835509, 4206.41110244566, 4213.620774130343, 4222.345536441856, 4224.852130175491, 4253.48958125027, 3796.5823759386444, 3799.3920972644796, 3810.8666196682984, 3816.580176180618, 3838.2131663009573, 4980.975095124573, 5002.199648056294, 5059.266406371129, 5065.898682026413, 5084.262781896604, 5361.571074314045, 5371.113766228606, 5401.837944861661, 5410.107332290207, 5452.645578037414, 4958.429780575208, 4966.826161084345, 4967.304577359173, 4974.602031837444, 5017.297578339036, 4558.270676691714, 4595.2188128018315, 4596.747178905192, 4603.608693261111, 4625.606823419979, 5581.302337207849, 5605.271314729141, 5623.6906970116215, 5624.156376543633, 5628.296462942132, 5396.9730151348995, 5407.675539467645, 5411.350637923317, 5420.268263784339, 5463.863403414946, 5479.315085614298, 5524.779008839601, 5581.888362232651, 5618.831435056954, 5657.773689052392, 5323.228131920927, 5367.1680889462195, 5370.677759334452, 5373.623846330719, 5394.676319420847, 5442.918356224581, 5450.209719590716, 5464.3442786865835, 5467.589930755289, 5489.725513724218, 5203.505666961632, 5208.687478751287, 5334.279872217201, 5350.170723537858, 5413.648112872808, 5280.498352656491, 5285.524302812765, 5286.920696189483, 5297.549708274686, 5299.682019078868, 5082.872928176826, 5177.508136727005, 5178.0679477694375, 5188.040212560688, 5237.135872581134, 5159.17453207485, 5314.256004159343, 5338.519533242027, 5401.891962160814, 5405.675659460445, 5186.766595503287, 5206.245094461357, 5207.3230480037355, 5208.895822083613, 5214.983078299847], "unit": "score", "name": "dojo.html", "value": 4993.290394306143}, {"lowerIsBetter": false, "replicates": [536.6833568194766, 539.1992890557522, 561.99719001405, 563.8618538458078, 584.6901142394527, 28870.56694149587, 29243.122706318816, 29252.414951700954, 36450.45324320131, 37016.259674806555, 40204.99487512813, 40687.18625627493, 40712.79643601778, 40725.0, 40740.59259407405, 8344.290735287508, 8550.01674807399, 8550.315974722038, 8552.78618034551, 8552.828943421127, 8242.340612750995, 8370.037445693732, 8380.8742868857, 8384.664613415456, 8396.748097557083, 8571.614277357503, 8648.0, 8667.17661822129, 8668.8699669505, 8669.21977022068, 8489.40574159806, 8562.272206862424, 8564.785880352978, 8578.613962371739, 8579.14208579137, 8367.497950123012, 8622.611982460805, 8630.180132887366, 8632.093630168805, 8634.0, 40210.0, 40879.1824163518, 40930.386044209066, 40961.26542284083, 41058.38412423816, 3277.655846136169, 3280.311134661724, 3345.7787907413863, 3427.2288735034667, 3790.9431358529646, 27208.863955680095, 29390.265243369086, 29428.0, 29496.705032949823, 29506.55740163899, 3907.1990242000606, 3976.642102210786, 4038.414429907647, 4040.6969477289026, 4193.412922190896, 276150.0, 277733.0, 277945.0, 277971.0, 277990.0, 55219.44780552143, 55234.447655523734, 55372.44627553673, 55386.72306638522, 55493.16760248599, 65275.67362163254, 65459.0, 65459.34540654628, 65505.67247163829, 65515.34484655092, 14881.702365952837, 15044.0, 15063.322150503254, 15071.698566028617, 15110.924445377923, 11510.654680359603, 11666.0, 11673.88326116745, 11687.0, 11716.765664686658, 19157.904210478857, 20279.391618251477, 20499.590008199753, 20588.176472941213, 20654.277100301417, 6704.631245281459, 7851.803704907423, 8059.919400805917, 8218.260356567938, 8262.876056859152, 889.3107841422949, 945.3429866243033, 955.9617615295449, 1042.2495803021811, 1094.6223552874246, 27006.32484187911, 27074.187774366408, 27160.1851944442, 27396.45207095847, 27501.724982749918, 1065.3448129400363, 1105.7346236903086, 1126.312949101064, 1148.2249481599886, 1192.076140990739, 14745.434930672584, 14961.015593762364, 15099.849001509845, 15215.391384344503, 15319.770203446957, 329935.0, 333560.0, 334021.0, 334195.0, 334459.0, 44009.77995110004, 44822.32766508505, 52277.7386113067, 52820.73589632027, 52832.47167528275, 1306.1118439461256, 1334.1861464506644, 1347.158026233604, 1353.472145863114, 1354.3769865861616, 26494.205173844817, 27380.863095684395, 29225.561616576193, 30629.771939753104, 32728.67271327256, 43731.78134109309, 43788.781056094514, 48819.26771098365, 49677.751611241714, 50585.747071264406, 320559.0, 320685.0, 321246.0, 322457.0, 322675.0, 41401.37897931473, 41966.370504441846, 42569.148617028106, 42640.0, 42691.0, 38550.80724596359, 39078.80460597679, 39127.0, 39242.411363830135, 39625.0, 33519.664803351654, 33612.833392359884, 33626.0, 33664.49503257502, 36329.27341453209, 35363.823180883934, 35865.28269434544, 35964.46053309255, 36214.63785362113, 36261.81869090637, 35335.82332088426, 35670.64329356777, 35848.82075589606, 36137.457938131476, 36138.0, 30605.0, 31638.841805790824, 32879.67120328862, 32906.50640240446, 32924.835375823925, 24822.751772482043, 25106.0, 25110.874445627654, 25219.923888721096, 25585.616215756407], "unit": "score", "name": "ext.html", "value": 18475.340337047055}, {"lowerIsBetter": false, "replicates": [369.66729943051234, 369.9038250054987, 369.90567405311646, 372.071681155517, 376.02984300504664, 13772.173669579832, 14462.638434039154, 15877.206139693013, 17751.911240443795, 18685.252589896405, 16475.44630582259, 16671.41650042249, 17178.656426871454, 17420.738688919646, 17490.21294041768, 5271.815486457975, 5353.411124776271, 5418.83743487696, 5422.864428389283, 5431.83704488866, 3952.2688302663955, 4090.1819636072755, 4093.7339072960312, 4103.2409004334295, 5330.0, 5606.775728970836, 5639.069553523664, 5809.0, 5814.5057670098095, 5815.505682017012, 5903.0, 5939.049752039696, 5943.078822782497, 5943.959807033773, 5947.345791962881, 5119.0, 5171.327727395452, 5221.817236396746, 5222.138347172712, 5261.473852614746, 20195.899020504803, 20256.898715506475, 20482.5903481931, 20501.8974905126, 20649.380518584316, 2180.4766855954617, 2203.46015226269, 2360.221127028077, 2371.0989823866994, 2648.735126487355, 6702.061711360365, 12297.954673852733, 12428.62714118578, 12826.871731282754, 13098.934505327412, 1856.9071546422624, 1864.7575815143944, 1886.7075603281514, 1886.7452893859427, 1893.3657224829699, 56328.0, 56571.43428565703, 56941.43058569403, 57840.71079644617, 58154.83690326212, 9738.90261097394, 9896.65361712351, 9972.0, 10028.247881408777, 10058.647947321808, 13158.0, 13206.27365494907, 13234.73530529384, 13252.337383130805, 13268.73462530744, 7372.373348265458, 7448.702051917971, 7520.398368130536, 7568.697252109964, 7570.924290757132, 7140.250273721288, 7165.104361954755, 7177.138743350727, 7199.3520583147765, 7217.458690598121, 5882.529397648178, 5989.880202395928, 5997.790077347272, 5999.730012149464, 6015.939840601538, 1682.6298214392814, 1747.3010795681828, 1754.3070487157502, 1795.8114397988284, 1816.5004623728316, 895.2614093372994, 900.6037343568809, 937.6296362936602, 971.5142428785607, 1022.9259277758324, 12780.872191278155, 15355.692886142215, 15755.68488630221, 15913.443029493912, 16648.417305394494, 904.1817155474306, 921.999630401009, 927.2026057590467, 949.0, 995.6764051683232, 8717.520536370434, 8922.330825188006, 9103.49930753815, 9151.405158664798, 9207.125323094295, 477558.0, 480659.0, 483834.0, 484334.0, 487077.0, 73758.0, 74029.25970740331, 74202.0, 77066.61466692743, 77258.61370693111, 1003.9899601003897, 1032.230987914009, 1158.7740390623746, 1168.9590864319878, 1175.482787573465, 14283.785743214068, 15073.164928421407, 15679.294431750826, 15707.293171807525, 15766.132862692662, 31329.53005704962, 34263.486047709805, 34325.65674343325, 35074.0, 35804.28391432209, 36889.44665830069, 42839.78580107079, 43403.34894976641, 43528.78235608801, 45018.77490612526, 6936.479764017819, 6963.721451141898, 7009.754658586925, 7083.858322833411, 7343.192248852729, 10240.231982601186, 10734.946325268324, 10753.193510486588, 11136.443177841238, 11366.261193022427, 9234.30742694314, 9249.907500925174, 9553.140217380469, 9735.26985476078, 9815.312928094965, 9342.205912497513, 9447.385919915183, 9511.476868772284, 9861.063198996084, 10134.0, 9148.496832674267, 9692.854607180758, 9846.753831154278, 10420.895791041992, 10501.159907207253, 7297.051383320135, 7391.2239214881665, 7460.142083660448, 7476.887846682413, 7551.093868735787, 8621.956890215508, 9053.954730226307, 9737.756556085871, 9854.26093043039, 10215.387076775418], "unit": "score", "name": "jquery.html", "value": 8253.979695993092}, {"lowerIsBetter": false, "replicates": [1336.5656161747422, 1408.5281430720709, 1456.0462896802594, 1596.9281382337795, 1784.6341499992502, 6821.488388370867, 7580.620968951551, 7724.382049436045, 7735.0, 7743.690252389898, 7428.777136685894, 7584.696612135522, 7597.506162099474, 7606.505577137482, 7609.54342739436, 1997.950051248716, 2045.1308194017558, 2048.2216757632077, 2281.4866655002616, 2311.537692461506, 2319.3969567912295, 2375.596148654733, 2381.9642705359433, 2382.392489915078, 2384.6065399209197, 2294.6902168207243, 2321.3732292281074, 2323.0939933425975, 2323.9186628468005, 2343.9062437502566, 2307.284741730061, 2322.3729593009875, 2329.767023297665, 2343.695319608457, 2347.401412639766, 2262.061244583496, 2267.8299127565497, 2285.691431656738, 2286.0512887151813, 2288.302067869299, 7808.687652493893, 7899.407544434191, 7904.051513818321, 7910.485818421784, 7916.6833326666865, 4844.467108618049, 4959.355283813117, 4960.33035540201, 4964.726940018298, 4967.180415231519, 3173.4922412413903, 3196.6643502432144, 3249.252671885456, 3349.413852575814, 3363.9495407568907, 1085.5494969587612, 1094.261373572843, 1102.735343517558, 1112.3548341961723, 1128.1651577832426, 10794.622188223453, 10810.945945270301, 10832.458377081115, 10839.620613278497, 10855.557499562614, 4364.323529852814, 4423.424954755861, 4424.778761061934, 4473.619742321939, 4480.439945006874, 9345.579448924678, 9356.34505584616, 9367.297452691075, 9374.0, 9380.24958003358, 4885.462599114095, 4890.364252647133, 4907.190313598217, 4920.581750551243, 4922.040202160616, 4409.977950110229, 4421.270490369053, 4443.933340999887, 4452.866414007585, 4467.508574056851, 3508.6666766657127, 3573.2496175802853, 3724.1248306647917, 3725.3108174987715, 3807.1433927366675, 1233.8457692788402, 1236.771197328497, 1242.6520574239228, 1252.9122961392616, 1255.8430196225472, 1282.7562763074986, 1319.9076064675573, 1321.7951217561294, 1349.9055066145472, 1369.2879702554617, 7238.203797582261, 7369.963150184322, 7372.299631534996, 7374.557526548424, 7375.778726638209, 1112.9888701112886, 1122.9494672739747, 1132.377192544114, 1135.1599816136, 1144.2733863996423, 5847.502962248172, 5939.406059394026, 5941.673207973603, 5951.196588460502, 5959.135925290809, 9054.411463254868, 9151.954240228757, 9194.540272986324, 9303.116203960613, 9305.581248843819, 9161.358704890594, 9185.402948808307, 9190.172884440433, 9194.494302813277, 9212.447253164832, 7214.6031968241205, 7318.377937875233, 7359.595222262827, 7396.704131834774, 7411.4070874331, 7327.157376901511, 7406.814829629302, 7407.074115735533, 7410.703571857281, 7411.851762964603, 8033.397495188001, 8140.389470789596, 8285.62714677853, 8401.70594029206, 8427.157284271523, 8346.374021948257, 8349.373796965374, 8383.790405239917, 8497.57512124379, 8529.616167272612, 6970.616616086164, 7120.145582530129, 7123.038389817309, 7124.430045596237, 7128.073350464407, 6678.83302917431, 6835.213950395768, 7133.500654954103, 7300.0, 7435.7025718970635, 6824.5564038339335, 6881.483888708467, 6912.44700423975, 6974.6512674367095, 7035.6833942471685, 6798.456123510206, 6875.449964002968, 6878.759243426456, 6956.513044086865, 6973.7210511581, 6907.6891539879825, 6955.408790252683, 6962.860742785015, 6962.895556566555, 6963.442924566124, 6319.52603554726, 6375.489960803032, 6442.130312407952, 6535.869282614416, 6556.0, 6605.438537724347, 6621.106150669598, 6651.0, 6656.434203092791, 6666.566673166229], "unit": "score", "name": "mootools.html", "value": 4554.051929199231}, {"lowerIsBetter": false, "replicates": [342.965703429657, 346.30565715739937, 348.7767828589703, 350.49878673496903, 350.65635677036494, 5683.772649094041, 5796.362400135987, 5841.123831425289, 5841.64950102993, 5842.649441033535, 5565.0, 5707.828765137042, 5730.598858079936, 5746.051901436268, 5751.56863235257, 4526.66050046247, 4527.253003254459, 4531.864044078667, 4533.662569541993, 4537.342085397632, 4299.50555686097, 4389.18800021997, 4423.402840616508, 4501.7524036178, 4522.3894774205555, 4480.6191473724775, 4481.731096134243, 4486.102779444124, 4490.910181796362, 4515.887102822439, 4479.574440428154, 4492.2812350024005, 4495.370648109268, 4498.077894031716, 4503.752293623849, 4013.6387725104883, 4014.096828213658, 4016.2971479990883, 4017.3773065174946, 4020.537638171589, 5406.351237851443, 5540.390557038722, 5544.029794785896, 5548.944510554883, 5551.528120109796, 5104.336436263299, 5115.669925819277, 5116.2069879168785, 5119.283300337956, 5182.922256166161, 5810.88378232433, 6125.785597504066, 6126.785562505335, 6139.877202455926, 6148.907766383508, 4139.4204811326435, 4221.2190744712325, 4270.338097594878, 4285.035866929947, 4294.849680261207, 6276.089966954812, 6321.367863213688, 6351.491880649537, 6356.555041147121, 6365.3634636536435, 4416.271315233015, 4417.558244175557, 4417.8232870684815, 4419.64642828573, 4426.623736982393, 4355.651547876162, 4475.4181956345465, 4480.596746292849, 4485.730856148642, 4488.192125417456, 5142.202958541432, 5159.58723302135, 5162.174052151638, 5165.1219292720325, 5166.070107380632, 6136.23297087864, 6147.631142131487, 6157.72290246931, 6159.599626024294, 6160.075988601656, 1567.2242240091227, 1591.0294720220656, 1591.053323272651, 1591.9602009949613, 1592.283472437408, 1048.1771809129796, 1050.81610718124, 1064.3401091323428, 1073.2487258918788, 1076.6931424543968, 5806.0129777937855, 5810.767569297265, 5819.883602328015, 5831.271091113526, 5835.883282334329, 6310.968445157745, 6332.1135041094285, 6400.07198956158, 6401.199850018747, 6404.327545607644, 5811.593188476766, 5812.738426770806, 5813.3895940925595, 5814.215080964016, 5818.272715910512, 3303.438415469376, 3403.931921361559, 3410.6418826023405, 3411.2154204533094, 3416.5046068320453, 6551.181102362205, 6562.146920900253, 6570.277269500351, 6575.276719560845, 6575.835604109936, 6456.612603243821, 6457.063725759833, 6464.256610489854, 6469.061986012096, 6471.546991710535, 6378.043293505918, 6541.738330466823, 6559.770408035696, 6599.8020059398295, 6623.337666233435, 6076.179715738319, 6249.0626406039455, 6294.496440284858, 6299.811005669837, 6302.086197501245, 6103.7558497661375, 6214.8135555933395, 6242.28213755424, 6280.466160376419, 6285.088662144055, 6585.407313341822, 6590.637514936724, 6590.901136483052, 6605.5376123670885, 6642.136522252076, 4382.0, 4478.865634030984, 4479.0, 4479.7536135512855, 4479.843205487792, 6353.809385718436, 6364.681765911779, 6365.045243213555, 6365.172527571386, 6373.968130159319, 6255.0, 6262.15460912771, 6265.342139075331, 6270.529710271839, 6272.780452684134, 5985.1022346646605, 6153.384661533811, 6169.784057557964, 6172.660503672341, 6181.350958149509, 6011.038233882733, 6057.303410107894, 6058.303295120942, 6066.514678825772, 6070.392960704071, 6228.781992630236, 6229.96885015572, 6232.75068997235, 6235.033569796688, 6241.063840423791, 5918.970405147947, 6044.576879618385, 6060.818175454743, 6066.211392518944, 6091.238595175603], "unit": "score", "name": "prototype.html", "value": 4663.003472600783}, {"lowerIsBetter": false, "replicates": [727.8617062758076, 752.086215248473, 798.7164556582413, 856.7643897928065, 873.5326600268853, 13949.442022319108, 14173.291335433212, 14178.645533861658, 14179.291035448225, 14227.0, 12748.745025099515, 13072.346382680875, 13092.279924604143, 13112.475500979974, 13772.93113534431, 810.5866008335732, 822.4941660878546, 824.2622852546997, 824.4435006370705, 824.7443292579289, 830.2652152844715, 833.125218520551, 835.2190701693905, 835.2900034970257, 836.3810780022769, 866.8699695045731, 868.1665601023026, 868.2533021601449, 868.9695860644879, 873.9825203495926, 864.0538610221797, 864.5115509736978, 864.8356812205661, 867.7179916527123, 875.2822685397977, 636.8535236895493, 637.1239545624766, 638.0174531221912, 638.4445532386807, 641.8940874755659, 12844.293563853984, 12887.226766394046, 12899.67750806228, 12944.0, 12957.870421295855, 11357.659270221906, 11412.20114591979, 11447.683516395555, 11500.94249528747, 11797.705057373549, 9732.464714440703, 9750.561224744904, 9788.265880058952, 9910.20718342531, 9974.451405172713, 3511.20997775501, 3585.515955346021, 3591.910202244939, 3626.0209743369405, 3682.429223470366, 44018.33972490415, 45066.77466612646, 46128.0, 50421.24368134481, 56091.43908560903, 10597.20520960931, 10761.30051546647, 10801.621943231949, 10854.565817367216, 10878.782424351468, 18755.968421736936, 18792.436226913214, 18793.624127517374, 18794.718079228824, 18859.434216973514, 7850.371970242367, 7952.880706789403, 7976.920230797734, 8097.838043239102, 8216.507009579444, 4552.6813123081065, 4576.81692732287, 4630.837920672828, 4727.929081063787, 4754.049190161982, 3088.7528997680133, 3097.3495565931407, 3114.1903105192814, 3116.2209447638093, 3120.095172400024, 566.5043087298614, 577.1314172170856, 580.0342429854329, 580.3876909860138, 590.3388205210106, 512.1140427061131, 569.8603842058723, 599.7241269016301, 704.3766266853769, 708.6067232685806, 8698.956505217433, 8766.780830479289, 8924.509151996703, 8992.145746154105, 9004.0, 567.9943200567941, 578.467809615155, 648.7145655911384, 663.6383171171723, 684.44901854007, 4026.255142798592, 4086.5504794472586, 4214.452121224222, 4223.640990515779, 4226.420332026317, 52788.736056319474, 54444.45555544473, 54517.454825452034, 54999.0, 55004.449955500735, 46200.3069953951, 48674.51325486771, 48786.0, 48858.75570622124, 50675.0, 40593.797031015245, 43455.56544434515, 44096.11807763891, 44119.33820992688, 45225.54774452213, 8847.557622118997, 9069.455832650063, 9138.223251023737, 9153.130452606993, 9193.448393096436, 29911.401771964003, 30414.84792576023, 34410.13974650654, 34866.82566587151, 35169.29661406706, 41823.58176418319, 47782.283265750346, 47942.52057479381, 48914.26628600645, 49384.0, 11372.943135284271, 11439.542418303508, 11599.76800464003, 11649.48608147757, 11746.119041072125, 11317.547298107984, 11343.0, 11683.941580292045, 12061.577844775391, 12354.814677779661, 11348.002436596373, 12037.819432708342, 12170.57402990891, 12528.436220369922, 12570.245785252913, 11771.764564708828, 12247.693807654523, 12549.247045176953, 12647.430865611253, 12665.113442058968, 11484.483198255932, 11638.24351417189, 11975.880241197476, 12338.13633045714, 12383.69040773988, 9580.856287155837, 9867.506624668882, 9912.801743964936, 10074.748131296776, 10224.130948869131, 9500.61997520119, 9734.172595329477, 9834.164096051629, 10228.64199753005, 10407.895921040692], "unit": "score", "name": "yui.html", "value": 6383.97578003224}], "name": "dromaeo_css", "value": 6849.193945392744}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 110.0, 110.0, 111.0, 111.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 150.0, 163.0, 128.0, 153.0, 151.0, 128.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 93.0, 101.0, 75.0, 73.0, 72.0, 122.0, 101.0, 71.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 142.0, 95.0, 97.0, 95.0, 143.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 108.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 147.0, 146.0, 146.0, 148.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 56.0, 56.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 81.0, 82.0, 90.0, 82.0, 84.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [122.0, 114.0, 115.0, 120.0, 120.0, 117.0, 117.0, 112.0, 120.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [141.0, 132.0, 138.0, 140.0, 139.0, 132.0, 138.0, 138.0, 145.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 66.0, 65.0, 64.0, 65.0, 68.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1487.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1257.861635220126], "unit": "score", "name": "RayTrace", "value": 588.2912550000001}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [572.4098454493417], "unit": "score", "name": "Splay", "value": 142.36477700000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19869.34305223555}]} 14:25:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19869.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1487.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6849.19"}}} 14:25:27 INFO - Return code: 0 14:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:27 INFO - # TBPL SUCCESS # 14:25:27 INFO - Running post-action listener: _resource_record_post_action 14:25:27 INFO - Running post-run listener: _resource_record_post_run 14:25:28 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 602112; Write bytes: 374448128; Read time: 100; Write time: 336880 14:25:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 75288576; Read time: 0; Write time: 64616 14:25:28 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 602112; Write bytes: 297922560; Read time: 100; Write time: 272172 14:25:28 INFO - Running post-run listener: _upload_blobber_files 14:25:28 INFO - Blob upload gear active. 14:25:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:25:28 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 14:25:28 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:25:28 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:25:29 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:30 INFO - (blobuploader) - INFO - Done attempting. 14:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:30 INFO - (blobuploader) - INFO - Done attempting. 14:25:30 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:30 INFO - Return code: 0 14:25:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:25:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/730263a2cdbe2c92f745b34afefbd4d32c86674b571724c5d7760204189aca95c772277abb48ccca18b0aac0d22b4890a306de5bafe641bf0ce3f17940ef5502", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4f4a07c56a894505c0e648c1d6ef8a0501cb7ee44c068aac2dfff255519ab941a2e5fb7e77a651ecb2c9074dde99c847af910a010e5bcd221b1583ba75bf1c94"} 14:25:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:25:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:25:30 INFO - Contents: 14:25:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/730263a2cdbe2c92f745b34afefbd4d32c86674b571724c5d7760204189aca95c772277abb48ccca18b0aac0d22b4890a306de5bafe641bf0ce3f17940ef5502", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4f4a07c56a894505c0e648c1d6ef8a0501cb7ee44c068aac2dfff255519ab941a2e5fb7e77a651ecb2c9074dde99c847af910a010e5bcd221b1583ba75bf1c94"} 14:25:30 INFO - Running post-run listener: copy_logs_to_upload_dir 14:25:30 INFO - Copying logs to upload dir... 14:25:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:25:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.379814 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-18 14:25:30.929425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 14:25:30.933026) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/730263a2cdbe2c92f745b34afefbd4d32c86674b571724c5d7760204189aca95c772277abb48ccca18b0aac0d22b4890a306de5bafe641bf0ce3f17940ef5502", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4f4a07c56a894505c0e648c1d6ef8a0501cb7ee44c068aac2dfff255519ab941a2e5fb7e77a651ecb2c9074dde99c847af910a010e5bcd221b1583ba75bf1c94"} build_url:https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/WvebXX7JQSuLS6NZsCAt1g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/730263a2cdbe2c92f745b34afefbd4d32c86674b571724c5d7760204189aca95c772277abb48ccca18b0aac0d22b4890a306de5bafe641bf0ce3f17940ef5502", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/4f4a07c56a894505c0e648c1d6ef8a0501cb7ee44c068aac2dfff255519ab941a2e5fb7e77a651ecb2c9074dde99c847af910a010e5bcd221b1583ba75bf1c94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 14:25:30.961394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:25:30.962209) ========= 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=232498196343f89f466a4a9a000001c8-1453154466.395568-1136892357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 14:25:31.045753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:25:31.046138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 14:25:31.046445) ========= ========= Total master_lag: 0.25 =========