builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1457149715.1 results: success (0) buildid: 20160304171029 builduid: e2b310ecb485460ea1fac84d4aaa2c1e revision: 20fd8603e83dc929b4be7e0c167cd8251dae46c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.097438) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.097918) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.098308) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003125 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.113724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.114037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.208967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.209270) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002187 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.260247) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.260629) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.261066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.261407) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 19:48:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 97.8M=0s 2016-03-04 19:48:35 (97.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.421621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.421953) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009307 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.469963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:35.470375) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20fd8603e83dc929b4be7e0c167cd8251dae46c7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20fd8603e83dc929b4be7e0c167cd8251dae46c7 --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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 19:48:35,816 truncating revision to first 12 chars 2016-03-04 19:48:35,816 Setting DEBUG logging. 2016-03-04 19:48:35,816 attempt 1/10 2016-03-04 19:48:35,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/20fd8603e83d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 19:48:36,079 unpacking tar archive at: mozilla-aurora-20fd8603e83d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:36.006527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:36.006922) ========= echo 20fd8603e83dc929b4be7e0c167cd8251dae46c7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'20fd8603e83dc929b4be7e0c167cd8251dae46c7'] 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20fd8603e83dc929b4be7e0c167cd8251dae46c7 program finished with exit code 0 elapsedTime=0.002349 script_repo_revision: '20fd8603e83dc929b4be7e0c167cd8251dae46c7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:36.057341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:36.057661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 19:48:36.063700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-04 19:48:36.064050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:48:36 INFO - MultiFileLogger online at 20160304 19:48:36 in /builds/slave/test-pgo 19:48:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:48:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:48:36 INFO - {'append_to_log': False, 19:48:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:48:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:48:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:48:36 INFO - 'branch': 'Mozilla-Aurora', 19:48:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:48:36 INFO - 'config_files': ('talos/linux_config.py',), 19:48:36 INFO - 'default_actions': ('clobber', 19:48:36 INFO - 'read-buildbot-config', 19:48:36 INFO - 'download-and-extract', 19:48:36 INFO - 'populate-webroot', 19:48:36 INFO - 'create-virtualenv', 19:48:36 INFO - 'install', 19:48:36 INFO - 'run-tests'), 19:48:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:48:36 INFO - 'download_minidump_stackwalk': True, 19:48:36 INFO - 'download_symbols': 'ondemand', 19:48:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:48:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:48:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:48:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:48:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:48:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:48:36 INFO - 'installer_path': 'installer.exe', 19:48:36 INFO - 'log_level': 'info', 19:48:36 INFO - 'log_name': 'talos', 19:48:36 INFO - 'log_to_console': True, 19:48:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:48:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:48:36 INFO - 'opt_config_files': (), 19:48:36 INFO - 'pip_index': False, 19:48:36 INFO - 'sps_profile': False, 19:48:36 INFO - 'sps_profile_interval': 0, 19:48:36 INFO - 'suite': 'dromaeojs-e10s', 19:48:36 INFO - 'system_bits': '32', 19:48:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:48:36 INFO - 'title': 'talos-linux64-ix-068', 19:48:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:48:36 INFO - 'use_talos_json': True, 19:48:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:48:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:48:36 INFO - 'work_dir': 'build'} 19:48:36 INFO - ##### 19:48:36 INFO - ##### Running clobber step. 19:48:36 INFO - ##### 19:48:36 INFO - Running pre-action listener: _resource_record_pre_action 19:48:36 INFO - Running main action method: clobber 19:48:36 INFO - rmtree: /builds/slave/test-pgo/build 19:48:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:48:36 INFO - Running post-action listener: _resource_record_post_action 19:48:36 INFO - ##### 19:48:36 INFO - ##### Running read-buildbot-config step. 19:48:36 INFO - ##### 19:48:36 INFO - Running pre-action listener: _resource_record_pre_action 19:48:36 INFO - Running main action method: read_buildbot_config 19:48:36 INFO - Using buildbot properties: 19:48:36 INFO - { 19:48:36 INFO - "project": "", 19:48:36 INFO - "product": "firefox", 19:48:36 INFO - "script_repo_revision": "production", 19:48:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:48:36 INFO - "repository": "", 19:48:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:48:36 INFO - "buildid": "20160304171029", 19:48:36 INFO - "pgo_build": "True", 19:48:36 INFO - "basedir": "/builds/slave/test-pgo", 19:48:36 INFO - "buildnumber": 113, 19:48:36 INFO - "slavename": "talos-linux64-ix-068", 19:48:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:48:36 INFO - "platform": "ubuntu64_hw", 19:48:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:48:36 INFO - "branch": "mozilla-aurora", 19:48:36 INFO - "repo_path": "releases/mozilla-aurora", 19:48:36 INFO - "revision": "20fd8603e83dc929b4be7e0c167cd8251dae46c7", 19:48:36 INFO - "stage_platform": "linux64-pgo", 19:48:36 INFO - "builduid": "e2b310ecb485460ea1fac84d4aaa2c1e", 19:48:36 INFO - "slavebuilddir": "test" 19:48:36 INFO - } 19:48:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 19:48:36 INFO - Running post-action listener: _resource_record_post_action 19:48:36 INFO - ##### 19:48:36 INFO - ##### Running download-and-extract step. 19:48:36 INFO - ##### 19:48:36 INFO - Running pre-action listener: _resource_record_pre_action 19:48:36 INFO - Running main action method: download_and_extract 19:48:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:48:36 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')]} 19:48:36 INFO - https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/test_packages.json 19:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/test_packages.json 19:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:48:42 INFO - Downloaded 1448 bytes. 19:48:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:48:42 INFO - Using the following test package requirements: 19:48:42 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 19:48:42 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:48:42 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:48:42 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'jsshell-linux-x86_64.zip'], 19:48:42 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:48:42 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 19:48:42 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:48:42 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:48:42 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:48:42 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 19:48:42 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 19:48:42 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:48:42 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:48: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')]} 19:48:42 INFO - https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:48:45 INFO - Downloaded 23097705 bytes. 19:48:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:48:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:48:46 INFO - Return code: 0 19:48:46 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:46 INFO - https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 19:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:48:48 INFO - Downloaded 23097705 bytes. 19:48:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:48:49 INFO - Return code: 0 19:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:49 INFO - https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:48:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 19:48:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 19:48:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 19:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:48:50 INFO - Downloaded 10801536 bytes. 19:48:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:48:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:48:51 INFO - Return code: 0 19:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:51 INFO - https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 19:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 19:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 19:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:48:52 INFO - Downloaded 59969945 bytes. 19:48:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 19:48:52 INFO - mkdir: /builds/slave/test-pgo/properties 19:48:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:48:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:48:52 INFO - Contents: 19:48:52 INFO - build_url:https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 19:48:53 INFO - Running post-action listener: _resource_record_post_action 19:48:53 INFO - Running post-action listener: set_extra_try_arguments 19:48:53 INFO - ##### 19:48:53 INFO - ##### Running populate-webroot step. 19:48:53 INFO - ##### 19:48:53 INFO - Running pre-action listener: _resource_record_pre_action 19:48:53 INFO - Running main action method: populate_webroot 19:48:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:48:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:48:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:48:53 INFO - '--tppagecycles', 19:48:53 INFO - '7'], 19:48:53 INFO - 'tests': ['tsvgm']}}, 19:48:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:48:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:48:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'tests': ['damp', 'tps']}, 19:48:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['damp', 'tps']}, 19:48:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:48:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:48:53 INFO - 'other': {'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'other_l64': {'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'other_nol64': {'tests': ['a11yr', 19:48:53 INFO - 'ts_paint', 19:48:53 INFO - 'tpaint', 19:48:53 INFO - 'sessionrestore', 19:48:53 INFO - 'sessionrestore_no_auto_restore']}, 19:48:53 INFO - 'svgr': {'tests': ['tsvgx', 19:48:53 INFO - 'tsvgr_opacity', 19:48:53 INFO - 'tart', 19:48:53 INFO - 'tscrollx', 19:48:53 INFO - 'cart']}, 19:48:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['tsvgx', 19:48:53 INFO - 'tsvgr_opacity', 19:48:53 INFO - 'tart', 19:48:53 INFO - 'tscrollx', 19:48:53 INFO - 'cart']}, 19:48:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'tests': ['tp5o']}, 19:48:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'talos_options': ['--e10s'], 19:48:53 INFO - 'tests': ['tp5o']}, 19:48:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'talos_options': ['--xperf_path', 19:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:53 INFO - 'tests': ['tp5n']}, 19:48:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:53 INFO - 'talos_options': ['--e10s', 19:48:53 INFO - '--xperf_path', 19:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:53 INFO - 'tests': ['tp5n']}}, 19:48:53 INFO - 'talos.zip': {'path': '', 19:48:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:48:53 INFO - Running post-action listener: _resource_record_post_action 19:48:53 INFO - ##### 19:48:53 INFO - ##### Running create-virtualenv step. 19:48:53 INFO - ##### 19:48:53 INFO - Running pre-action listener: _resource_record_pre_action 19:48:53 INFO - Running main action method: create_virtualenv 19:48:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:48:53 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 19:48:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:48:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:48:53 INFO - Using real prefix '/usr' 19:48:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:48:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:48:56 INFO - Installing pip.................done. 19:48:56 INFO - Return code: 0 19:48:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:48:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:48:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:48:56 INFO - Using env: {'DISPLAY': ':0', 19:48:56 INFO - 'HOME': '/home/cltbld', 19:48:56 INFO - 'LANG': 'en_US.UTF-8', 19:48:56 INFO - 'LANGUAGE': 'en_US:en', 19:48:56 INFO - 'LOGNAME': 'cltbld', 19:48:56 INFO - 'MAIL': '/var/mail/cltbld', 19:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:56 INFO - 'MOZ_NO_REMOTE': '1', 19:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:56 INFO - 'NO_EM_RESTART': '1', 19:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:56 INFO - 'SHELL': '/bin/bash', 19:48:56 INFO - 'SHLVL': '1', 19:48:56 INFO - 'TERM': 'linux', 19:48:56 INFO - 'TMOUT': '86400', 19:48:56 INFO - 'USER': 'cltbld', 19:48:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:56 INFO - '_': '/tools/buildbot/bin/python'} 19:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:56 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 19:48:56 INFO - Cleaning up... 19:48:56 INFO - Return code: 0 19:48:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:48:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:48:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:48:56 INFO - Using env: {'DISPLAY': ':0', 19:48:56 INFO - 'HOME': '/home/cltbld', 19:48:56 INFO - 'LANG': 'en_US.UTF-8', 19:48:56 INFO - 'LANGUAGE': 'en_US:en', 19:48:56 INFO - 'LOGNAME': 'cltbld', 19:48:56 INFO - 'MAIL': '/var/mail/cltbld', 19:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:56 INFO - 'MOZ_NO_REMOTE': '1', 19:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:56 INFO - 'NO_EM_RESTART': '1', 19:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:56 INFO - 'SHELL': '/bin/bash', 19:48:56 INFO - 'SHLVL': '1', 19:48:56 INFO - 'TERM': 'linux', 19:48:56 INFO - 'TMOUT': '86400', 19:48:56 INFO - 'USER': 'cltbld', 19:48:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:56 INFO - '_': '/tools/buildbot/bin/python'} 19:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:56 INFO - Downloading/unpacking psutil>=0.7.1 19:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:48:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:58 INFO - Installing collected packages: psutil 19:48:58 INFO - Running setup.py install for psutil 19:48:58 INFO - building 'psutil._psutil_linux' extension 19:48:58 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 19:48:58 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 19:48:58 INFO - building 'psutil._psutil_posix' extension 19:48:58 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 19:48:58 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 19:48:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:58 INFO - Successfully installed psutil 19:48:58 INFO - Cleaning up... 19:48:58 INFO - Return code: 0 19:48:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:48:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:48:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:48:58 INFO - Using env: {'DISPLAY': ':0', 19:48:58 INFO - 'HOME': '/home/cltbld', 19:48:58 INFO - 'LANG': 'en_US.UTF-8', 19:48:58 INFO - 'LANGUAGE': 'en_US:en', 19:48:58 INFO - 'LOGNAME': 'cltbld', 19:48:58 INFO - 'MAIL': '/var/mail/cltbld', 19:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:58 INFO - 'MOZ_NO_REMOTE': '1', 19:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:58 INFO - 'NO_EM_RESTART': '1', 19:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:58 INFO - 'SHELL': '/bin/bash', 19:48:58 INFO - 'SHLVL': '1', 19:48:58 INFO - 'TERM': 'linux', 19:48:58 INFO - 'TMOUT': '86400', 19:48:58 INFO - 'USER': 'cltbld', 19:48:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:58 INFO - '_': '/tools/buildbot/bin/python'} 19:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:49:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:49:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:49:00 INFO - Installing collected packages: mozsystemmonitor 19:49:00 INFO - Running setup.py install for mozsystemmonitor 19:49:00 INFO - Successfully installed mozsystemmonitor 19:49:00 INFO - Cleaning up... 19:49:00 INFO - Return code: 0 19:49:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:00 INFO - Using env: {'DISPLAY': ':0', 19:49:00 INFO - 'HOME': '/home/cltbld', 19:49:00 INFO - 'LANG': 'en_US.UTF-8', 19:49:00 INFO - 'LANGUAGE': 'en_US:en', 19:49:00 INFO - 'LOGNAME': 'cltbld', 19:49:00 INFO - 'MAIL': '/var/mail/cltbld', 19:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:00 INFO - 'MOZ_NO_REMOTE': '1', 19:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:00 INFO - 'NO_EM_RESTART': '1', 19:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:00 INFO - 'SHELL': '/bin/bash', 19:49:00 INFO - 'SHLVL': '1', 19:49:00 INFO - 'TERM': 'linux', 19:49:00 INFO - 'TMOUT': '86400', 19:49:00 INFO - 'USER': 'cltbld', 19:49:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:00 INFO - '_': '/tools/buildbot/bin/python'} 19:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:02 INFO - Downloading blobuploader-1.2.4.tar.gz 19:49:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:49:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:49:02 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 19:49:02 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 19:49:02 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 19:49:02 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 19:49:02 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 19:49:02 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 19:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:49:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:03 INFO - Downloading docopt-0.6.1.tar.gz 19:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:49:03 INFO - Installing collected packages: blobuploader, requests, docopt 19:49:03 INFO - Running setup.py install for blobuploader 19:49:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:49:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:49:03 INFO - Running setup.py install for requests 19:49:04 INFO - Running setup.py install for docopt 19:49:04 INFO - Successfully installed blobuploader requests docopt 19:49:04 INFO - Cleaning up... 19:49:04 INFO - Return code: 0 19:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 19:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 19:49:04 INFO - Using env: {'DISPLAY': ':0', 19:49:04 INFO - 'HOME': '/home/cltbld', 19:49:04 INFO - 'LANG': 'en_US.UTF-8', 19:49:04 INFO - 'LANGUAGE': 'en_US:en', 19:49:04 INFO - 'LOGNAME': 'cltbld', 19:49:04 INFO - 'MAIL': '/var/mail/cltbld', 19:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:04 INFO - 'MOZ_NO_REMOTE': '1', 19:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:04 INFO - 'NO_EM_RESTART': '1', 19:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:04 INFO - 'SHELL': '/bin/bash', 19:49:04 INFO - 'SHLVL': '1', 19:49:04 INFO - 'TERM': 'linux', 19:49:04 INFO - 'TMOUT': '86400', 19:49:04 INFO - 'USER': 'cltbld', 19:49:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:04 INFO - '_': '/tools/buildbot/bin/python'} 19:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:04 INFO - Running setup.py (path:/tmp/pip-uyDQfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:04 INFO - Running setup.py (path:/tmp/pip-9tP1X1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:04 INFO - Running setup.py (path:/tmp/pip-dKrVWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:04 INFO - Running setup.py (path:/tmp/pip-6vwkxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:04 INFO - Running setup.py (path:/tmp/pip-YMR9H7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:04 INFO - Running setup.py (path:/tmp/pip-uviADs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:04 INFO - Running setup.py (path:/tmp/pip-kee9U2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:04 INFO - Running setup.py (path:/tmp/pip-TkWjKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:04 INFO - Running setup.py (path:/tmp/pip-hRi0tH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:04 INFO - Running setup.py (path:/tmp/pip-wTimAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:04 INFO - Running setup.py (path:/tmp/pip-dZPqqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:04 INFO - Running setup.py (path:/tmp/pip-w1fEQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:05 INFO - Running setup.py (path:/tmp/pip-YjdJWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:05 INFO - Running setup.py (path:/tmp/pip-thYiVF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:05 INFO - Running setup.py (path:/tmp/pip-wsUIOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:05 INFO - Running setup.py (path:/tmp/pip-sYcLTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:05 INFO - Running setup.py (path:/tmp/pip-zrw0YV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:49:05 INFO - Running setup.py install for manifestparser 19:49:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:49:05 INFO - Running setup.py install for mozcrash 19:49:05 INFO - Running setup.py install for mozdebug 19:49:05 INFO - Running setup.py install for mozdevice 19:49:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:49:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:49:05 INFO - Running setup.py install for mozfile 19:49:05 INFO - Running setup.py install for mozhttpd 19:49:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:49:05 INFO - Running setup.py install for mozinfo 19:49:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:49:05 INFO - Running setup.py install for mozInstall 19:49:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Running setup.py install for mozleak 19:49:06 INFO - Running setup.py install for mozlog 19:49:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Running setup.py install for moznetwork 19:49:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Running setup.py install for mozprocess 19:49:06 INFO - Running setup.py install for mozprofile 19:49:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Running setup.py install for mozrunner 19:49:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Running setup.py install for mozscreenshot 19:49:06 INFO - Running setup.py install for moztest 19:49:06 INFO - Running setup.py install for mozversion 19:49:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:49:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:06 INFO - Cleaning up... 19:49:06 INFO - Return code: 0 19:49:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:06 INFO - Using env: {'DISPLAY': ':0', 19:49:06 INFO - 'HOME': '/home/cltbld', 19:49:06 INFO - 'LANG': 'en_US.UTF-8', 19:49:06 INFO - 'LANGUAGE': 'en_US:en', 19:49:06 INFO - 'LOGNAME': 'cltbld', 19:49:06 INFO - 'MAIL': '/var/mail/cltbld', 19:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:06 INFO - 'MOZ_NO_REMOTE': '1', 19:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:06 INFO - 'NO_EM_RESTART': '1', 19:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:06 INFO - 'SHELL': '/bin/bash', 19:49:06 INFO - 'SHLVL': '1', 19:49:06 INFO - 'TERM': 'linux', 19:49:06 INFO - 'TMOUT': '86400', 19:49:06 INFO - 'USER': 'cltbld', 19:49:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:06 INFO - '_': '/tools/buildbot/bin/python'} 19:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:07 INFO - Running setup.py (path:/tmp/pip-ZkE27K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:07 INFO - Running setup.py (path:/tmp/pip-Pd1Fxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:07 INFO - Running setup.py (path:/tmp/pip-QjNJ5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:07 INFO - Running setup.py (path:/tmp/pip-BQpDcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:07 INFO - Running setup.py (path:/tmp/pip-YZ2pZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:07 INFO - Running setup.py (path:/tmp/pip-aYb17M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:07 INFO - Running setup.py (path:/tmp/pip-rdUCKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:07 INFO - Running setup.py (path:/tmp/pip-TFDi5O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:07 INFO - Running setup.py (path:/tmp/pip-IQA9rW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:07 INFO - Running setup.py (path:/tmp/pip-26kXfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:07 INFO - Running setup.py (path:/tmp/pip-SqcOpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:07 INFO - Running setup.py (path:/tmp/pip-a8QDfb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:07 INFO - Running setup.py (path:/tmp/pip-WNBnWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:07 INFO - Running setup.py (path:/tmp/pip-7ebKau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:07 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)) 19:49:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:07 INFO - Running setup.py (path:/tmp/pip-67Pnfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:08 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)) 19:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:08 INFO - Running setup.py (path:/tmp/pip-3SHlVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:08 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)) 19:49:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:08 INFO - Running setup.py (path:/tmp/pip-bKUeec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:08 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)) 19:49:08 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)) 19:49:08 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)) 19:49:08 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)) 19:49:08 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)) 19:49:08 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)) 19:49:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:09 INFO - Downloading blessings-1.6.tar.gz 19:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:10 INFO - Installing collected packages: blessings 19:49:10 INFO - Running setup.py install for blessings 19:49:10 INFO - Successfully installed blessings 19:49:10 INFO - Cleaning up... 19:49:10 INFO - Return code: 0 19:49:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:49:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:10 INFO - Reading from file tmpfile_stdout 19:49:10 INFO - Current package versions: 19:49:10 INFO - argparse == 1.2.1 19:49:10 INFO - blessings == 1.6 19:49:10 INFO - blobuploader == 1.2.4 19:49:10 INFO - docopt == 0.6.1 19:49:10 INFO - manifestparser == 1.1 19:49:10 INFO - mozInstall == 1.12 19:49:10 INFO - mozcrash == 0.16 19:49:10 INFO - mozdebug == 0.1 19:49:10 INFO - mozdevice == 0.48 19:49:10 INFO - mozfile == 1.2 19:49:10 INFO - mozhttpd == 0.7 19:49:10 INFO - mozinfo == 0.9 19:49:10 INFO - mozleak == 0.1 19:49:10 INFO - mozlog == 3.1 19:49:10 INFO - moznetwork == 0.27 19:49:10 INFO - mozprocess == 0.22 19:49:10 INFO - mozprofile == 0.28 19:49:10 INFO - mozrunner == 6.11 19:49:10 INFO - mozscreenshot == 0.1 19:49:10 INFO - mozsystemmonitor == 0.0 19:49:10 INFO - moztest == 0.7 19:49:10 INFO - mozversion == 1.4 19:49:10 INFO - psutil == 3.1.1 19:49:10 INFO - requests == 1.2.3 19:49:10 INFO - wsgiref == 0.1.2 19:49:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:10 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')]} 19:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 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')]} 19:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:10 INFO - Using env: {'DISPLAY': ':0', 19:49:10 INFO - 'HOME': '/home/cltbld', 19:49:10 INFO - 'LANG': 'en_US.UTF-8', 19:49:10 INFO - 'LANGUAGE': 'en_US:en', 19:49:10 INFO - 'LOGNAME': 'cltbld', 19:49:10 INFO - 'MAIL': '/var/mail/cltbld', 19:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:10 INFO - 'MOZ_NO_REMOTE': '1', 19:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:10 INFO - 'NO_EM_RESTART': '1', 19:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:10 INFO - 'SHELL': '/bin/bash', 19:49:10 INFO - 'SHLVL': '1', 19:49:10 INFO - 'TERM': 'linux', 19:49:10 INFO - 'TMOUT': '86400', 19:49:10 INFO - 'USER': 'cltbld', 19:49:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:10 INFO - '_': '/tools/buildbot/bin/python'} 19:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 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)) 19:49:10 INFO - Cleaning up... 19:49:10 INFO - Return code: 0 19:49:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:49:10 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')]} 19:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 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')]} 19:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:10 INFO - Using env: {'DISPLAY': ':0', 19:49:10 INFO - 'HOME': '/home/cltbld', 19:49:10 INFO - 'LANG': 'en_US.UTF-8', 19:49:10 INFO - 'LANGUAGE': 'en_US:en', 19:49:10 INFO - 'LOGNAME': 'cltbld', 19:49:10 INFO - 'MAIL': '/var/mail/cltbld', 19:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:10 INFO - 'MOZ_NO_REMOTE': '1', 19:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:10 INFO - 'NO_EM_RESTART': '1', 19:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:10 INFO - 'SHELL': '/bin/bash', 19:49:10 INFO - 'SHLVL': '1', 19:49:10 INFO - 'TERM': 'linux', 19:49:10 INFO - 'TMOUT': '86400', 19:49:10 INFO - 'USER': 'cltbld', 19:49:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:10 INFO - '_': '/tools/buildbot/bin/python'} 19:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:10 INFO - Downloading/unpacking jsonschema 19:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:12 INFO - Downloading/unpacking functools32 (from jsonschema) 19:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:12 INFO - warning: no files found matching '*.txt' 19:49:12 INFO - no previously-included directories found matching 'build' 19:49:12 INFO - no previously-included directories found matching 'dist' 19:49:12 INFO - no previously-included directories found matching '.git*' 19:49:12 INFO - Installing collected packages: jsonschema, functools32 19:49:12 INFO - Running setup.py install for functools32 19:49:12 INFO - warning: no files found matching '*.txt' 19:49:12 INFO - no previously-included directories found matching 'build' 19:49:12 INFO - no previously-included directories found matching 'dist' 19:49:12 INFO - no previously-included directories found matching '.git*' 19:49:12 INFO - Successfully installed jsonschema functools32 19:49:12 INFO - Cleaning up... 19:49:13 INFO - Return code: 0 19:49:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:49:13 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')]} 19:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:13 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')]} 19:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f5d559e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1f290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', '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 19:49:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 19:49:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 19:49:13 INFO - Using env: {'DISPLAY': ':0', 19:49:13 INFO - 'HOME': '/home/cltbld', 19:49:13 INFO - 'LANG': 'en_US.UTF-8', 19:49:13 INFO - 'LANGUAGE': 'en_US:en', 19:49:13 INFO - 'LOGNAME': 'cltbld', 19:49:13 INFO - 'MAIL': '/var/mail/cltbld', 19:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:13 INFO - 'MOZ_NO_REMOTE': '1', 19:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:13 INFO - 'NO_EM_RESTART': '1', 19:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:13 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:13 INFO - 'SHELL': '/bin/bash', 19:49:13 INFO - 'SHLVL': '1', 19:49:13 INFO - 'TERM': 'linux', 19:49:13 INFO - 'TMOUT': '86400', 19:49:13 INFO - 'USER': 'cltbld', 19:49:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:13 INFO - '_': '/tools/buildbot/bin/python'} 19:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:13 INFO - Downloading/unpacking flake8 19:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:49:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:49:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 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 19:49:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:49:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:15 INFO - no previously-included directories found matching 'docs/_build' 19:49:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:49:15 INFO - Running setup.py install for pep8 19:49:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:15 INFO - no previously-included directories found matching 'docs/_build' 19:49:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:49:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:49:15 INFO - Cleaning up... 19:49:15 INFO - Return code: 0 19:49:15 INFO - Running post-action listener: _resource_record_post_action 19:49:15 INFO - Running post-action listener: _start_resource_monitoring 19:49:15 INFO - Starting resource monitoring. 19:49:15 INFO - ##### 19:49:15 INFO - ##### Running install step. 19:49:15 INFO - ##### 19:49:15 INFO - Running pre-action listener: _resource_record_pre_action 19:49:15 INFO - Running main action method: install 19:49:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:16 INFO - Reading from file tmpfile_stdout 19:49:16 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:49:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:49:16 INFO - Reading from file tmpfile_stdout 19:49:16 INFO - Output received: 19:49:16 INFO - Usage: mozinstall [options] installer 19:49:16 INFO - Options: 19:49:16 INFO - -h, --help show this help message and exit 19:49:16 INFO - -d DEST, --destination=DEST 19:49:16 INFO - Directory to install application into. [default: 19:49:16 INFO - "/builds/slave/test-pgo"] 19:49:16 INFO - --app=APP Application being installed. [default: firefox] 19:49:16 INFO - mkdir: /builds/slave/test-pgo/build/application 19:49:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:49:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:49:31 INFO - Reading from file tmpfile_stdout 19:49:31 INFO - Output received: 19:49:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:49:31 INFO - Running post-action listener: _resource_record_post_action 19:49:31 INFO - ##### 19:49:31 INFO - ##### Running run-tests step. 19:49:31 INFO - ##### 19:49:31 INFO - Running pre-action listener: _resource_record_pre_action 19:49:31 INFO - Running main action method: run_tests 19:49:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:49:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:49:31 INFO - Python 2.7.3 19:49:31 INFO - Return code: 0 19:49:31 INFO - grabbing minidump binary from tooltool 19:49: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')]} 19:49:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb1850>, '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 0x2c1d330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1d7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:49:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:49:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:49:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:49:31 INFO - Return code: 0 19:49:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:49:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:49:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:49:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:49:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:49:32 INFO - Return code: 0 19:49:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 19:49:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:49:32 INFO - Using env: {'DISPLAY': ':0', 19:49:32 INFO - 'HOME': '/home/cltbld', 19:49:32 INFO - 'LANG': 'en_US.UTF-8', 19:49:32 INFO - 'LANGUAGE': 'en_US:en', 19:49:32 INFO - 'LOGNAME': 'cltbld', 19:49:32 INFO - 'MAIL': '/var/mail/cltbld', 19:49:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:32 INFO - 'MOZ_NO_REMOTE': '1', 19:49:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:32 INFO - 'NO_EM_RESTART': '1', 19:49:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:49:32 INFO - 'SHELL': '/bin/bash', 19:49:32 INFO - 'SHLVL': '1', 19:49:32 INFO - 'TERM': 'linux', 19:49:32 INFO - 'TMOUT': '86400', 19:49:32 INFO - 'USER': 'cltbld', 19:49:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318', 19:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:32 INFO - '_': '/tools/buildbot/bin/python'} 19:49:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:49:32 INFO - mozversion application_buildid: 20160304171029 19:49:32 INFO - mozversion application_changeset: 20fd8603e83dc929b4be7e0c167cd8251dae46c7 19:49:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:49:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:49:32 INFO - mozversion application_name: Firefox 19:49:32 INFO - mozversion application_remotingname: firefox-dev 19:49:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:49:32 INFO - mozversion application_vendor: Mozilla 19:49:32 INFO - mozversion application_version: 46.0a2 19:49:32 INFO - mozversion platform_buildid: 20160304171029 19:49:32 INFO - mozversion platform_changeset: 20fd8603e83dc929b4be7e0c167cd8251dae46c7 19:49:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:49:32 INFO - mozversion platform_version: 46.0a2 19:49:32 INFO - using testdate: 1457149772 19:49:32 INFO - actual date: 1457149772 19:49:32 INFO - starting webserver on 'localhost:33008' 19:49:32 INFO - SUITE-START | Running 3 tests 19:49:32 INFO - TEST-START | dromaeo_css 19:49:32 INFO - operating with platform_type : linux_ 19:49:32 INFO - Initialising browser for dromaeo_css test... 19:49:32 INFO - TEST-INFO | started process 26306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFIboZT/profile http://localhost:33008/getInfo.html) 19:49:36 INFO - PROCESS | 26306 | 19:49:36 INFO - PROCESS | 26306 | (process:26385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:49:37 INFO - PROCESS | 26306 | __metrics Screen width/height:1600/1200 19:49:37 INFO - PROCESS | 26306 | colorDepth:24 19:49:37 INFO - PROCESS | 26306 | Browser inner width/height: 1024/697 19:49:37 INFO - PROCESS | 26306 | __metrics 19:49:38 INFO - TEST-INFO | 26306: exit 0 19:49:38 INFO - Browser initialized. 19:49:38 INFO - Running cycle 1/1 for dromaeo_css test... 19:49:38 INFO - TEST-INFO | started process 26434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFIboZT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:39 INFO - PROCESS | 26434 | 19:49:39 INFO - PROCESS | 26434 | (process:26498): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:49:49 INFO - PROCESS | 26434 | RSS: Main: 140410880 19:49:49 INFO - PROCESS | 26434 | 19:50:39 INFO - PROCESS | 26434 | 1457149839254 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] 19:52:46 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33008/tests/dromaeo/cssquery-ext.html) 19:52:47 INFO - PROCESS | 26434 | RSS: Main: 144830464 19:52:47 INFO - PROCESS | 26434 | 19:55:49 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-ext.html (next: http://localhost:33008/tests/dromaeo/cssquery-jquery.html) 19:55:49 INFO - PROCESS | 26434 | RSS: Main: 144277504 19:55:49 INFO - PROCESS | 26434 | 19:58:51 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33008/tests/dromaeo/cssquery-mootools.html) 19:58:52 INFO - PROCESS | 26434 | RSS: Main: 143048704 19:58:52 INFO - PROCESS | 26434 | 20:01:53 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33008/tests/dromaeo/cssquery-prototype.html) 20:01:54 INFO - PROCESS | 26434 | RSS: Main: 142729216 20:01:54 INFO - PROCESS | 26434 | 20:04:56 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33008/tests/dromaeo/cssquery-yui.html) 20:04:56 INFO - PROCESS | 26434 | RSS: Main: 143257600 20:04:56 INFO - PROCESS | 26434 | 20:07:58 INFO - PROCESS | 26434 | Cycle 1(1): loaded http://localhost:33008/tests/dromaeo/cssquery-yui.html (next: http://localhost:33008/tests/dromaeo/cssquery-dojo.html) 20:07:59 INFO - PROCESS | 26434 | RSS: Main: 144629760 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | __start_tp_report 20:07:59 INFO - PROCESS | 26434 | _x_x_mozilla_page_load 20:07:59 INFO - PROCESS | 26434 | _x_x_mozilla_page_load_details 20:07:59 INFO - PROCESS | 26434 | |i|pagename|runs| 20:07:59 INFO - PROCESS | 26434 | |0;dojo.html;3275.377678241134;3292.522584225289;3302.24048468852;3330.5170750241214;3337.5327454156413;5286.995470860538;5287.709175995319;5319.574434045277;5327.0943939530225;5366.409694933554;5365.651232669874;5383.569314454844;5396.352437707481;5403;5409.702466364349;4873.195922672764;4939.728314942677;4948.925766113512;4963.205887058071;5069.771860266297;4697.6241900647865;4825.806967721287;4875.902481950359;4916.631252656047;4997.375328083989;4903.8774030649165;4938.407391113072;4958.975205123969;4968.627352948525;4995.025969935864;4901.019796040806;4907.1657818171;4925.852224433273;4927.408710954673;4928.43323017854;4737.384140061805;4829.203181475053;4838.782254798542;4846.0550192712435;4913.680610760325;5069.873253168664;5103.897922041576;5121.103806833789;5150.665206761549;5178.275041494194;5707.286589176353;5748.65508069513;5749.913751293692;5756.7985120521;5766.365699773021;5603.635763675348;5696.800611978602;5719.14212868069;5747.453991870766;5828.795992140254;5346.091164502044;5386.165144402624;5396.514313711785;5397.73011349431;5397.811076612339;5837.474627283565;5838.2702162229725;5839.386864379264;5860.472557469848;5862.824115276549;5474.945250547523;5560.193771903051;5570.749316280777;5606.831795046155;5619;5755.3381361143165;5759.740811663485;5764.193012978187;5771.220885180531;5791.276090488689;5509.807156749494;5703.201551782754;5738.282714660668;5739.569532285095;5781.479666830005;5539.695316757617;5631.099024156116;5636.154576813511;5650.26546548946;5725.2843394575675;4358.738475691469;4391.187630288407;4393.890152746207;4406.052698669737;4436.800343984529;3819.083419979185;3969.8412063517712;3977.0455090778005;3978.42312864633;3997.480327557399;5290.259363689087;5335.706536140549;5439.075357189287;5480.205370221375;5500.532454741312;5702.6863522506665;5771.567132465082;5780.306363236355;5782.277215348082;5787.826365209051;5255.710935898563;5407.783688652488;5487.204355368449;5509.47659972302;5526.917096243559;4780.115678599401;4805.8558243252755;4876.634252431082;4893.584045356113;4971.651984361132;5862.413758624103;5958.404159584007;5966.343702192756;5969.2240008799445;5981.850453738692;5592.916106258328;5671.801486948102;5744.965906136768;5857.502112320415;5883.058710606454;5851.1515830205235;5856.970715146397;5905.232319798399;5906.173135761082;5917.5857689961285;5676.091825307931;5691.288588926384;5694.003549378925;5697.430256974435;5697.943020569741;5571.832845014656;5610.49505544503;5632.605717599728;5738.483536481736;5743.310802703702;5599;5630.380658127685;5674.007048766532;5675.460831221028;5680.091185410314;5627.43725627434;5635.239242702347;5640.717964101696;5648.209250704823;5652.745626446737;5322.042032434199;5466.043442397644;5474.972625136849;5479.780808767605;5500.1749737539685;5563.805266815642;5627.465390787868;5665.830025099253;5693.146028095819;5706.087026075808;5545.833624991256;5560.972195138998;5561.082421400585;5561.499465048165;5564.888702226014 20:07:59 INFO - PROCESS | 26434 | |1;ext.html;481.3117242343452;532.3691425660592;561.7472137538108;582.2779753106147;608.4280776070497;30329;37311.62688373119;37966.8101659492;38108.61891381082;38147.23705525895;40601.796991015006;40853;40925.59074409255;40995.59004409955;41123.17753644925;8535.957320213405;8717.215450609443;8726.171013753716;8735.825283494327;8743.650253989832;8461.703840365588;8552.059273479912;8565.186307300797;8591.699290524833;8606.5696715164;8615.052344242129;8899.911000890006;8907.866382004275;8908.643654253821;8934.865977010317;8755.562221888911;8818.20636142747;8842.690505832297;8852.468851868909;8866.601002954818;8708;8750.606222719993;8801.823963520757;8864.42381245217;8870.112988701143;40917.38623920643;41403.171936561404;41507;41511.7924410376;41544.37683434751;3315.635280119185;3350.6481819408855;3378.121688361019;3523.119220194951;3874.3607304794673;30962.690373096208;31015;31099.37801243985;31676;31739;4184.079502509473;4245.341971994346;4309.978450107761;4339.370791235285;4345.869623911288;280379;282609;283151;284765;334338.99999999756;59280.11079833806;59548.40451595429;59817.10274345888;59945;59970;62978.37021629725;63353;63360.36639633545;63563.364366355745;63647;17929.641407171785;17995.370162044266;18015.909920450576;18037.549061273574;18197.27210911575;14073.577792666236;14395.928020360041;14649.633759156106;14691.338889749986;14776.852231477762;18922.62154756897;21146.788532114482;21670.78329216719;21691.24080657201;21699.132034718434;8321.251087402163;8740.519271440005;8767.772511848347;8806.207441330183;8855.203031727175;1044.6030508406757;1141.2353723005606;1163.66253786401;1255.9058070644737;1257.283348491351;30028.399432011236;32119.197020074218;34341.484877726856;34628.30743385169;34662.48006279908;1114.1922106472905;1133.3200079951962;1151.844500992372;1170.0464121740754;1203.975920481603;14710.55868323952;14745.92627036858;14994.925025374803;15129.924350378398;15327.846721532866;384737;512362;528447;530925;826996;53668.73165634147;53785;54118;54276;54586.45413545893;1465;1489.2256026865969;1493.6340596553914;1508.4720347878156;1508.5398953319122;29825.25436864096;30748;31119.688803112585;31867.840660796548;31896.36207275795;46038.539614604764;46632.30051549297;46640;46697.766511168586;46861.18832870039;303215;304090;304233;304427;304793;32858.835705822275;33688.82089126869;33734.15664608405;33848.66151338554;34055.148621284665;42739.78630106829;43465.78267108644;43525.34711979386;44028.77985610051;44451.77774111109;38193.42709859299;38419.231615366974;38986.4152037714;39096.2180756389;39335.803320984356;40339;41728.3740743883;41892.581074190086;42281.154376912906;42415.7879210602;37013.81493092625;37171.07072323214;37268.254634907695;42186.57813421949;42414.5758542423;31850.36299274048;32813.83593082019;34317.48523772195;34412.48381274233;39623.40564891471;26957;27481.86259068692;27588.6889974153;27632;27876.72123278741 20:07:59 INFO - PROCESS | 26434 | |2;jquery.html;382.59968515234266;384.21236465246244;385.8239529056123;387.29705584364376;387.79640688638443;15701.450449234278;17038.636909047276;18746.62506749864;18798;19306.517337066547;11151.107911367071;11295.548178072868;11470.483828227729;17037.659246815056;17424.3030278789;4984.501549845023;5220.347456567929;5221.71280579568;5262.868428289305;5283.313169287987;5138.66598671087;5362.0616392131415;5548;5594.272744543204;5635.619273278053;5524.226608274845;5572.86067848303;5595.916061259064;5651.632643878155;6209.968950155243;6125.111858780452;6132.540059495555;6143.10924915887;6145.324014358417;6163.784267550636;5294.788208471657;5459.372172200208;5465.207544906006;5475.397706252309;5544.334679838405;13052;13117.212967221902;20271.79728202714;21236;21245.78754212469;2124.9787502124937;2197.604431202383;2197.923072692448;2297.529006553669;2414.806815454777;9397.342186046979;9647.179989700884;9733.270004749673;10023.548940297704;13208.33958302081;1870.9438716838517;1917.3289348727974;1923.9615207695908;1924.8460123190112;1925.9422217333502;60356.39643603552;60380.69809650967;61279.693601531704;61501.38498615001;62321.37678623247;10738.624148154777;10768.78462430747;10806.621768238074;10810;10884.891151088388;12911.806322905164;13946.790798138036;13981.11254980585;14078.296085195903;14097.942654300969;6392.4246817786625;6627.403533681992;7866.881996770053;8266.297364723945;8299.95850020746;7958.08482024563;7963.800904977422;7991.360691144694;8005.239502247277;8019.719309824128;4466.173757854807;4642.280446530793;4678.742669153161;4685.835995740133;4719.4100737407825;1947.4060411574324;1957.168203513501;1982.4350060232764;1984.2261518007988;1984.7221389005551;443.9223135951196;456.5617007672605;995.4723996281982;1013.6604237580345;1075.7794652096459;10871.347719136877;11409.771804564029;11509.654710358702;11514.654560363202;11544.653660390202;476.3949783774587;489.24411783794125;500.8497450764756;501.6237821633775;974.6637410093506;7469.439792015621;9416.834586916126;9418;9458.196053335407;9726.027397260359;574690;582624;588591;589640;608822;65966.34033659603;67096.32903670998;69050.65474672595;77010.61494692603;78567;1145.0953746540306;1187.6674531131298;1193.2184419205435;1202.6091520255952;1238.8637249902683;16125.516234512983;16186.028838269742;16295.51113466598;16383.426580069641;16452.177391130157;33446.498302525;34076.31847363088;34094.48858267078;35112;35606.643933560335;43780.78109609432;43832.342514861666;44247.33628995632;44597.77701111474;45535.54464455446;7202.855942881009;7494.175640679412;7750.341220996053;7763.456558040883;7771.261730135628;10388.688339349832;10835.729106772078;10959.452027398758;11182.776344473228;11328.32030078198;10504.527296271839;10547.683569492927;10577.100946419641;10718;10874.238803283693;9636.22910167171;9691.70924872255;9877.456739879088;10284.897151028394;10689.9465502672;9608.327417080738;9796.510174491104;10072.899271007489;10272.435016074187;10731.141508679131;7811.921880781119;8003.719869804529;8031.879521807061;8064.072631647436;8073.475224110649;9543.952280238833;10091.142252908585;10161.898381016095;10190.082892539707;10224.693259202237 20:07:59 INFO - PROCESS | 26434 | |3;mootools.html;1540.6687562174134;1556.859882610565;1758.3933542927693;1845.8154184581535;1874.4470381237534;7603.201663825294;7656.617169141548;7815.6873725051;7828.725994590191;7879.763607091789;7869.80325491863;7889.763307100782;7980.680772769082;7989.280964713174;8000.439969202158;2321.791038806507;2338.590746619335;2340.169239919821;2341.4497593065616;2349.6123139682018;2373.774491423312;2383.9880800595975;2392.126873691099;2399.892004859777;2409.2410890569504;2275.1923067311113;2284.166279308049;2331.743508214095;2332.4518738096535;2343.6367363058666;2319.257837492003;2346.683197768305;2359.917402890899;2361.7638236176244;2364.47981444082;2320.1879342230254;2345.155743932183;2349.6592994015773;2350.106959355434;2356.7171939367213;7886.605669716491;7915.366770658334;7933.72231971884;7934.206579342077;7965.123836377994;4869.488703686097;4931.186354251544;4967.528084831935;4974.527419895104;5003.574696150831;3098.1634958561062;3216.9195770105703;3254.332861763333;3262.429074911881;3276.934461310784;1117.017025017979;1117.5027112934747;1119.283658458587;1121.6130434999911;1122.343429093981;10730;10738.140948724084;10760.946195268974;10761.139108871272;10831.783364332668;4330.458692663417;4357.956420435755;4406.62543683784;4473.776311184428;4484.865454036384;8721.825563488821;8727.65089396417;8744.956275218583;8752.956235218782;8760.08019157992;4857.052874689472;4888.9755551222015;4911.68074075184;4913.87715307113;4920.827771027997;4442.2892337225885;4457.041736026705;4480.126375356775;4502.752348620857;4530.139273538017;3490.1449144959647;3572.8034958077037;3576.5171701819922;3585.4442561403025;3596.496490491333;1022.5296363672645;1035.1201478743008;1036.4972988100765;1073.5705717712976;1078.7896360209684;1136.9829452558217;1141.9486123124314;1182.4206138991833;1357.8710022547841;1413.8162038934872;7232.783016509513;7358.227386124487;7419.035525381666;7422.740204092939;7438.070241219848;1142.6229344316355;1162.6686394377562;1193.498730533178;1195.647284051207;1202.6331968749441;5986.940130598726;6004.099385092271;6019.187409699722;6031.4270144336215;6031.849203769941;8927.553622318857;9381.718548443558;9469.857952130724;9552.092551207625;9555.856662150074;9301.72094837156;9368.718938431857;9383.812323753487;9406.623735050658;9433.339666223435;7203.207647158808;7425.108986921604;7499.400047996147;7515.436342274351;7568.281013303727;7127.786166415016;7134.108236470442;7142.5724023837565;7217.133943926762;7217.6391180441815;8231.38264630167;8279.089300176855;8416.663333466593;8574.27118694918;8598.484090954562;8374.958125209336;8755.562221889008;8843.867341989746;8844.071372506052;8867;6676.298988606321;6760.391564759196;6783.423409010289;6788.083608712761;6791.524593278621;7213;7267.055282813412;7273.672684729094;7274.30894065063;7319.268073192638;7069.363757261665;7217.06178196831;7226.277372262732;7270.890936635848;7302.0142280791415;6300.495960323255;6893.827654308482;6920.446364290945;6941.861162776817;6995.265497122728;6929.44564434834;7002.089728335284;7030.543014704028;7049.471289653399;7093.113360829896;6413.422791948747;6450.741970321134;6468.288488266193;6479.967600161969;6485.902711459237;6438.484921206198;6513.120728701565;6515.218173818982;6648.202215734143;6667.833304167435 20:07:59 INFO - PROCESS | 26434 | |4;prototype.html;360.3783473508197;364.382371879664;364.4660572261636;373.46407904656826;379.3816079789942;6288.213973253343;6288.905666414996;6294.05589161626;6309.873802523953;6425.518086143535;6177.81466556004;6297.2128483939505;6317.084022816689;6351.523635727316;6354.0786585945125;4761.357216775726;4776.976115119428;4797.088553174885;4800.399950006249;4808.567228949394;4749.216379297429;4776.976115119437;4778.259369797687;4785.593224575915;4809.941812801196;4613.1696294666945;4748.097861406339;4760.8333708320215;4765.380500534926;4784.354112194861;4741.668083234175;4746.881327966794;4755.072760811643;4758.928616070762;4767.785449654774;4122.835086596532;4124.876253712393;4129.091599848029;4136.276151673475;4139.958600413987;5992.79025234119;6010.519158467312;6015.819525414245;6015.947209238366;6036.667983260919;5391.649542779707;5505.724713764336;5508.14623733322;5512.6692398456225;5526.530244929186;6622.801315960529;6648.734050637969;6654.13496245485;6658.833529161761;6691.531592788507;4483.887902802423;4498.370228168026;4522.050369422425;4527.139843429771;4529.614982726473;6776.898346524806;6869.313068693091;6944.1666999959825;6960.199577048603;6960.65196740161;4745.572898439157;4758.42898852133;4778.880527986758;4812.975935120302;4821.397325334333;4798.1123492154065;4875.24433712775;4889.877753056202;4889.951100488949;4900.995295964319;5525.557955363642;5549.972250138723;5567.832965011056;5579.944200558024;5592.692401917852;6584.8024559263295;6715.925451927766;6716.429103526158;6727.260001399842;6733.158355205599;1651.6036151323835;1704.233095107182;1710.9315627375015;1712.0070359191639;1715.3395942561954;1150.6317978247048;1151.3552410650063;1157.1379322404694;1158.0446131941183;1163.1218430085232;6350.682465876687;6363.681815909186;6455.967720161463;6469.547131700736;6500.5449618526245;6859.862802743917;6879.931200688029;6927.3419025192525;6936.7572134975035;6959.88641817317;6402.583832050902;6441.420272175433;6456.741730330828;6461.386168314003;6494.4479719223455;3751.2309976454762;3752.4746535485056;3767.5102236709054;3769.6041915599017;3777.660010599004;7084.858302834017;7087.7164913402885;7131.643417829087;7141.571505709674;7143.9642801786695;6894.13823272091;7087.015635622034;7109.8933515997305;7116.466265030143;7125.1093613298335;7059.470539709439;7080.256573059857;7101.715931362791;7101.786946391617;7117.145942486831;6894.482913781386;6900.378965893094;6900.723971041102;6925.792226233221;6926.44588432914;6669.699863506251;6792.864142717217;6799;6823;6849.863002739818;7074.893876591752;7093.113360829896;7106.467014973794;7119.466040046914;7129.322714342129;4792.281157826354;4796.232602783538;4807.990322032272;4815.855524334275;4828.66199366041;6832.555883867532;6880.58716477013;6891.241963383924;6898.551594146365;6921.169459664872;6673.8998915015345;6683.331666833278;6689.862723336947;6692.83267918306;6710.765123220664;6646;6677.332266773284;6684.0642310075655;6699.799006029827;6718.865622687616;6414.903776443264;6542.280349161683;6551.115599394021;6554.901676474761;6579.901301480578;6651.035599838093;6673.9332606673315;6682.9331706682315;6699.564528305645;6719.428848547928;6518.794023105741;6520.021996700533;6579.078928950046;6598.208215014229;6609.173853268341 20:07:59 INFO - PROCESS | 26434 | |5;yui.html;768.3660979691753;785.897833281674;807.8061265296329;852.028687296482;894.1282249806435;14497.130172189663;14649.633759156;14663;14688.706225875476;14716.77924831127;12074.577389791359;12079.637610871667;12102.09234307426;12136;12179.33013684247;859.1751918158544;867.4665080975186;889.4974339498195;891.6433426629335;898.9505577193285;895.1451363947447;895.9830592277779;898.0435835834847;900.4372267332917;900.4597241654988;940.6378544260475;943.4150826487553;944.0276515189366;944.6079876851098;947.3889341374809;924.3852837862813;924.708716754227;931.5528546297782;936.1013427109982;938.141600435604;683.3917813146304;684.9520533562653;685.4345165238698;685.8251145957798;687.8589889072728;15520.92239538795;15562.37750489979;15562.37750489979;15577.376904923904;15646;13698.863011369858;13790.65523361924;13835.861641383557;13842.861571384257;13846.100003499841;11402.71493212668;11543.96104350604;11549.94225028878;11557.364344961024;11852.288862668267;3856.768593884376;3860.1507668312925;3860.6718428933573;3902.609739026103;3919.490466239399;51338.48661513374;51496;53620.73189634066;53808.99999999961;53933.46066539363;10431.530581123867;10590.576376944837;11060.115190784718;11083.612073577386;11092;19296.903515482612;19311.227550897805;19319.613607727766;19320.4203873884;19405.902970485058;8092.676292948334;8311.542865142354;8357.540335281496;8370.372222083368;8394.076651568323;4694.624430045588;4730.479647238801;4793.736344501016;4933.950660493421;4953.975230123826;3339.1652086978256;3396;3406.131436483681;3412.982935085309;3413.7269018478464;591.8490784849836;593.9435753603401;602.4878852975024;604.1843511259764;606.3633185155569;617.8756798370856;662.2847324889108;681.9727210911607;703.0508813102373;712.0885266858429;9105.81788364229;9515.666951656658;9544;9617.663381781604;9627.374220675634;604.6976511744128;635.9951276982357;716.7992961970657;729.824842037907;754.8867669849457;4348.695591308578;4424.247877860771;4490.506044335186;4695.600873925686;4729.763511824395;54060;54929;55035.72482137644;55106;55912.89263056916;49501.50498495041;49564.50435495671;50005.49994500081;50157.74921125444;51814.22278665823;47234;49764.75117624389;50385.244221337445;51300;51414.48585514172;9606.519674016132;9702.029797020241;9712.805743884941;9776.26677999167;9839.458829764431;37035.444468332455;37504.43743343907;38585.42121868118;38721;38730.6126938727;42064.78967605143;44100.55899441093;46006;47015;47215.055698886514;11778.587749428729;11902.880971190523;11934.52261909514;12012.399380030789;12264.754704905674;13080.672983175496;13130.803037954629;13221.735565288447;13412.865871341162;13919.582412527641;12431.93784031074;12487.31319777421;12596.622101336974;13195.274259915797;13534.120282181626;12064.819027714415;12189.634310970685;12471.812922806346;12521.56174533887;12639.494420223456;11747.588834390755;12194.573189938665;12366.505339786308;12627.305498197687;12920.676983075498;10264.230182736175;10396.272260941661;10417.9479102604;10469.68590942273;10824.134069274282;10219.846702299621;10794.136469082612;10921.781564368826;10941.617043403761;10945.398003109905 20:07:59 INFO - PROCESS | 26434 | __end_tp_report 20:07:59 INFO - PROCESS | 26434 | __start_cc_report 20:07:59 INFO - PROCESS | 26434 | _x_x_mozilla_cycle_collect,270 20:07:59 INFO - PROCESS | 26434 | __end_cc_report 20:07:59 INFO - PROCESS | 26434 | __startTimestamp1457150879048__endTimestamp 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | ------- Summary: start ------- 20:07:59 INFO - PROCESS | 26434 | Number of tests: 6 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#0] dojo.html Cycles:165 Average:5325.47 Median:5539.70 stddev:576.39 (10.4%) stddev-sans-first:555.27 20:07:59 INFO - PROCESS | 26434 | Values: 3275.4 3292.5 3302.2 3330.5 3337.5 5287.0 5287.7 5319.6 5327.1 5366.4 5365.7 5383.6 5396.4 5403.0 5409.7 4873.2 4939.7 4948.9 4963.2 5069.8 4697.6 4825.8 4875.9 4916.6 4997.4 4903.9 4938.4 4959.0 4968.6 4995.0 4901.0 4907.2 4925.9 4927.4 4928.4 4737.4 4829.2 4838.8 4846.1 4913.7 5069.9 5103.9 5121.1 5150.7 5178.3 5707.3 5748.7 5749.9 5756.8 5766.4 5603.6 5696.8 5719.1 5747.5 5828.8 5346.1 5386.2 5396.5 5397.7 5397.8 5837.5 5838.3 5839.4 5860.5 5862.8 5474.9 5560.2 5570.7 5606.8 5619.0 5755.3 5759.7 5764.2 5771.2 5791.3 5509.8 5703.2 5738.3 5739.6 5781.5 5539.7 5631.1 5636.2 5650.3 5725.3 4358.7 4391.2 4393.9 4406.1 4436.8 3819.1 3969.8 3977.0 3978.4 3997.5 5290.3 5335.7 5439.1 5480.2 5500.5 5702.7 5771.6 5780.3 5782.3 5787.8 5255.7 5407.8 5487.2 5509.5 5526.9 4780.1 4805.9 4876.6 4893.6 4971.7 5862.4 5958.4 5966.3 5969.2 5981.9 5592.9 5671.8 5745.0 5857.5 5883.1 5851.2 5857.0 5905.2 5906.2 5917.6 5676.1 5691.3 5694.0 5697.4 5697.9 5571.8 5610.5 5632.6 5738.5 5743.3 5599.0 5630.4 5674.0 5675.5 5680.1 5627.4 5635.2 5640.7 5648.2 5652.7 5322.0 5466.0 5475.0 5479.8 5500.2 5563.8 5627.5 5665.8 5693.1 5706.1 5545.8 5561.0 5561.1 5561.5 5564.9 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#1] ext.html Cycles:180 Average:55114.24 Median:39041.32 stddev:109915.26 (281.5%) stddev-sans-first:110147.06 20:07:59 INFO - PROCESS | 26434 | Values: 481.3 532.4 561.7 582.3 608.4 30329.0 37311.6 37966.8 38108.6 38147.2 40601.8 40853.0 40925.6 40995.6 41123.2 8536.0 8717.2 8726.2 8735.8 8743.7 8461.7 8552.1 8565.2 8591.7 8606.6 8615.1 8899.9 8907.9 8908.6 8934.9 8755.6 8818.2 8842.7 8852.5 8866.6 8708.0 8750.6 8801.8 8864.4 8870.1 40917.4 41403.2 41507.0 41511.8 41544.4 3315.6 3350.6 3378.1 3523.1 3874.4 30962.7 31015.0 31099.4 31676.0 31739.0 4184.1 4245.3 4310.0 4339.4 4345.9 280379.0 282609.0 283151.0 284765.0 334339.0 59280.1 59548.4 59817.1 59945.0 59970.0 62978.4 63353.0 63360.4 63563.4 63647.0 17929.6 17995.4 18015.9 18037.5 18197.3 14073.6 14395.9 14649.6 14691.3 14776.9 18922.6 21146.8 21670.8 21691.2 21699.1 8321.3 8740.5 8767.8 8806.2 8855.2 1044.6 1141.2 1163.7 1255.9 1257.3 30028.4 32119.2 34341.5 34628.3 34662.5 1114.2 1133.3 1151.8 1170.0 1204.0 14710.6 14745.9 14994.9 15129.9 15327.8 384737.0 512362.0 528447.0 530925.0 826996.0 53668.7 53785.0 54118.0 54276.0 54586.5 1465.0 1489.2 1493.6 1508.5 1508.5 29825.3 30748.0 31119.7 31867.8 31896.4 46038.5 46632.3 46640.0 46697.8 46861.2 303215.0 304090.0 304233.0 304427.0 304793.0 32858.8 33688.8 33734.2 33848.7 34055.1 42739.8 43465.8 43525.3 44028.8 44451.8 38193.4 38419.2 38986.4 39096.2 39335.8 40339.0 41728.4 41892.6 42281.2 42415.8 37013.8 37171.1 37268.3 42186.6 42414.6 31850.4 32813.8 34317.5 34412.5 39623.4 26957.0 27481.9 27588.7 27632.0 27876.7 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#2] jquery.html Cycles:180 Average:29058.37 Median:22345.63 stddev:96193.93 (430.5%) stddev-sans-first:96439.67 20:07:59 INFO - PROCESS | 26434 | Values: 382.6 384.2 385.8 387.3 387.8 15701.5 17038.6 18746.6 18798.0 19306.5 11151.1 11295.5 11470.5 17037.7 17424.3 4984.5 5220.3 5221.7 5262.9 5283.3 5138.7 5362.1 5548.0 5594.3 5635.6 5524.2 5572.9 5595.9 5651.6 6210.0 6125.1 6132.5 6143.1 6145.3 6163.8 5294.8 5459.4 5465.2 5475.4 5544.3 13052.0 13117.2 20271.8 21236.0 21245.8 2125.0 2197.6 2197.9 2297.5 2414.8 9397.3 9647.2 9733.3 10023.5 13208.3 1870.9 1917.3 1924.0 1924.8 1925.9 60356.4 60380.7 61279.7 61501.4 62321.4 10738.6 10768.8 10806.6 10810.0 10884.9 12911.8 13946.8 13981.1 14078.3 14097.9 6392.4 6627.4 7866.9 8266.3 8300.0 7958.1 7963.8 7991.4 8005.2 8019.7 4466.2 4642.3 4678.7 4685.8 4719.4 1947.4 1957.2 1982.4 1984.2 1984.7 443.9 456.6 995.5 1013.7 1075.8 10871.3 11409.8 11509.7 11514.7 11544.7 476.4 489.2 500.8 501.6 974.7 7469.4 9416.8 9418.0 9458.2 9726.0 574690.0 582624.0 588591.0 589640.0 608822.0 65966.3 67096.3 69050.7 77010.6 78567.0 1145.1 1187.7 1193.2 1202.6 1238.9 16125.5 16186.0 16295.5 16383.4 16452.2 33446.5 34076.3 34094.5 35112.0 35606.6 43780.8 43832.3 44247.3 44597.8 45535.5 7202.9 7494.2 7750.3 7763.5 7771.3 10388.7 10835.7 10959.5 11182.8 11328.3 10504.5 10547.7 10577.1 10718.0 10874.2 9636.2 9691.7 9877.5 10284.9 10689.9 9608.3 9796.5 10072.9 10272.4 10731.1 7811.9 8003.7 8031.9 8064.1 8073.5 9544.0 10091.1 10161.9 10190.1 10224.7 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#3] mootools.html Cycles:180 Average:5519.93 Median:6356.96 stddev:2797.68 (44.0%) stddev-sans-first:2789.54 20:07:59 INFO - PROCESS | 26434 | Values: 1540.7 1556.9 1758.4 1845.8 1874.4 7603.2 7656.6 7815.7 7828.7 7879.8 7869.8 7889.8 7980.7 7989.3 8000.4 2321.8 2338.6 2340.2 2341.4 2349.6 2373.8 2384.0 2392.1 2399.9 2409.2 2275.2 2284.2 2331.7 2332.5 2343.6 2319.3 2346.7 2359.9 2361.8 2364.5 2320.2 2345.2 2349.7 2350.1 2356.7 7886.6 7915.4 7933.7 7934.2 7965.1 4869.5 4931.2 4967.5 4974.5 5003.6 3098.2 3216.9 3254.3 3262.4 3276.9 1117.0 1117.5 1119.3 1121.6 1122.3 10730.0 10738.1 10760.9 10761.1 10831.8 4330.5 4358.0 4406.6 4473.8 4484.9 8721.8 8727.7 8745.0 8753.0 8760.1 4857.1 4889.0 4911.7 4913.9 4920.8 4442.3 4457.0 4480.1 4502.8 4530.1 3490.1 3572.8 3576.5 3585.4 3596.5 1022.5 1035.1 1036.5 1073.6 1078.8 1137.0 1141.9 1182.4 1357.9 1413.8 7232.8 7358.2 7419.0 7422.7 7438.1 1142.6 1162.7 1193.5 1195.6 1202.6 5986.9 6004.1 6019.2 6031.4 6031.8 8927.6 9381.7 9469.9 9552.1 9555.9 9301.7 9368.7 9383.8 9406.6 9433.3 7203.2 7425.1 7499.4 7515.4 7568.3 7127.8 7134.1 7142.6 7217.1 7217.6 8231.4 8279.1 8416.7 8574.3 8598.5 8375.0 8755.6 8843.9 8844.1 8867.0 6676.3 6760.4 6783.4 6788.1 6791.5 7213.0 7267.1 7273.7 7274.3 7319.3 7069.4 7217.1 7226.3 7270.9 7302.0 6300.5 6893.8 6920.4 6941.9 6995.3 6929.4 7002.1 7030.5 7049.5 7093.1 6413.4 6450.7 6468.3 6480.0 6485.9 6438.5 6513.1 6515.2 6648.2 6667.8 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#4] prototype.html Cycles:180 Average:5583.30 Median:6383.13 stddev:1680.57 (26.3%) stddev-sans-first:1638.93 20:07:59 INFO - PROCESS | 26434 | Values: 360.4 364.4 364.5 373.5 379.4 6288.2 6288.9 6294.1 6309.9 6425.5 6177.8 6297.2 6317.1 6351.5 6354.1 4761.4 4777.0 4797.1 4800.4 4808.6 4749.2 4777.0 4778.3 4785.6 4809.9 4613.2 4748.1 4760.8 4765.4 4784.4 4741.7 4746.9 4755.1 4758.9 4767.8 4122.8 4124.9 4129.1 4136.3 4140.0 5992.8 6010.5 6015.8 6015.9 6036.7 5391.6 5505.7 5508.1 5512.7 5526.5 6622.8 6648.7 6654.1 6658.8 6691.5 4483.9 4498.4 4522.1 4527.1 4529.6 6776.9 6869.3 6944.2 6960.2 6960.7 4745.6 4758.4 4778.9 4813.0 4821.4 4798.1 4875.2 4889.9 4890.0 4901.0 5525.6 5550.0 5567.8 5579.9 5592.7 6584.8 6715.9 6716.4 6727.3 6733.2 1651.6 1704.2 1710.9 1712.0 1715.3 1150.6 1151.4 1157.1 1158.0 1163.1 6350.7 6363.7 6456.0 6469.5 6500.5 6859.9 6879.9 6927.3 6936.8 6959.9 6402.6 6441.4 6456.7 6461.4 6494.4 3751.2 3752.5 3767.5 3769.6 3777.7 7084.9 7087.7 7131.6 7141.6 7144.0 6894.1 7087.0 7109.9 7116.5 7125.1 7059.5 7080.3 7101.7 7101.8 7117.1 6894.5 6900.4 6900.7 6925.8 6926.4 6669.7 6792.9 6799.0 6823.0 6849.9 7074.9 7093.1 7106.5 7119.5 7129.3 4792.3 4796.2 4808.0 4815.9 4828.7 6832.6 6880.6 6891.2 6898.6 6921.2 6673.9 6683.3 6689.9 6692.8 6710.8 6646.0 6677.3 6684.1 6699.8 6718.9 6414.9 6542.3 6551.1 6554.9 6579.9 6651.0 6673.9 6682.9 6699.6 6719.4 6518.8 6520.0 6579.1 6598.2 6609.2 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - PROCESS | 26434 | [#5] yui.html Cycles:180 Average:14578.09 Median:25350.31 stddev:16265.34 (64.2%) stddev-sans-first:16277.91 20:07:59 INFO - PROCESS | 26434 | Values: 768.4 785.9 807.8 852.0 894.1 14497.1 14649.6 14663.0 14688.7 14716.8 12074.6 12079.6 12102.1 12136.0 12179.3 859.2 867.5 889.5 891.6 899.0 895.1 896.0 898.0 900.4 900.5 940.6 943.4 944.0 944.6 947.4 924.4 924.7 931.6 936.1 938.1 683.4 685.0 685.4 685.8 687.9 15520.9 15562.4 15562.4 15577.4 15646.0 13698.9 13790.7 13835.9 13842.9 13846.1 11402.7 11544.0 11549.9 11557.4 11852.3 3856.8 3860.2 3860.7 3902.6 3919.5 51338.5 51496.0 53620.7 53809.0 53933.5 10431.5 10590.6 11060.1 11083.6 11092.0 19296.9 19311.2 19319.6 19320.4 19405.9 8092.7 8311.5 8357.5 8370.4 8394.1 4694.6 4730.5 4793.7 4934.0 4954.0 3339.2 3396.0 3406.1 3413.0 3413.7 591.8 593.9 602.5 604.2 606.4 617.9 662.3 682.0 703.1 712.1 9105.8 9515.7 9544.0 9617.7 9627.4 604.7 636.0 716.8 729.8 754.9 4348.7 4424.2 4490.5 4695.6 4729.8 54060.0 54929.0 55035.7 55106.0 55912.9 49501.5 49564.5 50005.5 50157.7 51814.2 47234.0 49764.8 50385.2 51300.0 51414.5 9606.5 9702.0 9712.8 9776.3 9839.5 37035.4 37504.4 38585.4 38721.0 38730.6 42064.8 44100.6 46006.0 47015.0 47215.1 11778.6 11902.9 11934.5 12012.4 12264.8 13080.7 13130.8 13221.7 13412.9 13919.6 12431.9 12487.3 12596.6 13195.3 13534.1 12064.8 12189.6 12471.8 12521.6 12639.5 11747.6 12194.6 12366.5 12627.3 12920.7 10264.2 10396.3 10417.9 10469.7 10824.1 10219.8 10794.1 10921.8 10941.6 10945.4 20:07:59 INFO - PROCESS | 26434 | -------- Summary: end -------- 20:07:59 INFO - PROCESS | 26434 | 20:07:59 INFO - TEST-INFO | 26434: exit 0 20:07:59 INFO - TEST-OK | dromaeo_css | took 1106928ms 20:07:59 INFO - TEST-START | kraken 20:07:59 INFO - operating with platform_type : linux_ 20:07:59 INFO - Initialising browser for kraken test... 20:07:59 INFO - TEST-INFO | started process 26682 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0pWjJe/profile http://localhost:33008/getInfo.html) 20:08:02 INFO - PROCESS | 26682 | 20:08:02 INFO - PROCESS | 26682 | (process:26763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:08:03 INFO - PROCESS | 26682 | __metrics Screen width/height:1600/1200 20:08:03 INFO - PROCESS | 26682 | colorDepth:24 20:08:03 INFO - PROCESS | 26682 | Browser inner width/height: 1024/697 20:08:03 INFO - PROCESS | 26682 | __metrics 20:08:04 INFO - TEST-INFO | 26682: exit 0 20:08:04 INFO - Browser initialized. 20:08:04 INFO - Running cycle 1/1 for kraken test... 20:08:04 INFO - TEST-INFO | started process 26812 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0pWjJe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:05 INFO - PROCESS | 26812 | 20:08:05 INFO - PROCESS | 26812 | (process:26877): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:08:16 INFO - PROCESS | 26812 | RSS: Main: 140849152 20:08:16 INFO - PROCESS | 26812 | 20:08:18 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33008/tests/kraken/driver.html?testName=audio-beat-detection) 20:08:19 INFO - PROCESS | 26812 | RSS: Main: 145653760 20:08:19 INFO - PROCESS | 26812 | 20:08:21 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33008/tests/kraken/driver.html?testName=audio-dft) 20:08:22 INFO - PROCESS | 26812 | RSS: Main: 144662528 20:08:22 INFO - PROCESS | 26812 | 20:08:25 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33008/tests/kraken/driver.html?testName=audio-fft) 20:08:25 INFO - PROCESS | 26812 | RSS: Main: 145674240 20:08:25 INFO - PROCESS | 26812 | 20:08:27 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33008/tests/kraken/driver.html?testName=audio-oscillator) 20:08:28 INFO - PROCESS | 26812 | RSS: Main: 144097280 20:08:28 INFO - PROCESS | 26812 | 20:08:30 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:08:30 INFO - PROCESS | 26812 | RSS: Main: 146341888 20:08:30 INFO - PROCESS | 26812 | 20:08:33 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33008/tests/kraken/driver.html?testName=imaging-darkroom) 20:08:34 INFO - PROCESS | 26812 | RSS: Main: 146243584 20:08:34 INFO - PROCESS | 26812 | 20:08:37 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33008/tests/kraken/driver.html?testName=imaging-desaturate) 20:08:38 INFO - PROCESS | 26812 | RSS: Main: 146595840 20:08:38 INFO - PROCESS | 26812 | 20:08:41 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33008/tests/kraken/driver.html?testName=json-parse-financial) 20:08:41 INFO - PROCESS | 26812 | RSS: Main: 144920576 20:08:41 INFO - PROCESS | 26812 | 20:08:43 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:08:43 INFO - PROCESS | 26812 | RSS: Main: 144961536 20:08:43 INFO - PROCESS | 26812 | 20:08:45 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:08:46 INFO - PROCESS | 26812 | RSS: Main: 144789504 20:08:46 INFO - PROCESS | 26812 | 20:08:47 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:08:48 INFO - PROCESS | 26812 | RSS: Main: 144957440 20:08:48 INFO - PROCESS | 26812 | 20:08:50 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:08:51 INFO - PROCESS | 26812 | RSS: Main: 144707584 20:08:51 INFO - PROCESS | 26812 | 20:08:53 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:08:54 INFO - PROCESS | 26812 | RSS: Main: 146341888 20:08:54 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | Cycle 1(1): loaded http://localhost:33008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33008/tests/kraken/driver.html?testName=ai-astar) 20:08:56 INFO - PROCESS | 26812 | RSS: Main: 147210240 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | __start_tp_report 20:08:56 INFO - PROCESS | 26812 | _x_x_mozilla_page_load 20:08:56 INFO - PROCESS | 26812 | _x_x_mozilla_page_load_details 20:08:56 INFO - PROCESS | 26812 | |i|pagename|runs| 20:08:56 INFO - PROCESS | 26812 | |0;ai-astar;114;107;113;112;113;122;112;114;112;115 20:08:56 INFO - PROCESS | 26812 | |1;audio-beat-detection;166;142;159;162;130;153;153;131;164;132 20:08:56 INFO - PROCESS | 26812 | |2;audio-dft;163;164;166;163;167;163;165;163;168;167 20:08:56 INFO - PROCESS | 26812 | |3;audio-fft;80;74;77;158;78;76;75;73;154;78 20:08:56 INFO - PROCESS | 26812 | |4;audio-oscillator;98;96;137;97;97;97;137;96;97;135 20:08:56 INFO - PROCESS | 26812 | |5;imaging-gaussian-blur;112;111;116;110;111;111;110;111;111;110 20:08:56 INFO - PROCESS | 26812 | |6;imaging-darkroom;149;150;149;149;150;147;148;149;149;147 20:08:56 INFO - PROCESS | 26812 | |7;imaging-desaturate;97;96;98;96;97;97;100;100;97;97 20:08:56 INFO - PROCESS | 26812 | |8;json-parse-financial;54;56;56;55;55;58;57;63;53;54 20:08:56 INFO - PROCESS | 26812 | |9;json-stringify-tinderbox;65;64;64;65;65;65;65;65;65;65 20:08:56 INFO - PROCESS | 26812 | |10;stanford-crypto-aes;83;81;81;82;81;87;82;81;83;82 20:08:56 INFO - PROCESS | 26812 | |11;stanford-crypto-ccm;122;124;114;115;124;115;123;127;124;121 20:08:56 INFO - PROCESS | 26812 | |12;stanford-crypto-pbkdf2;143;134;143;132;138;141;149;138;139;131 20:08:56 INFO - PROCESS | 26812 | |13;stanford-crypto-sha256-iterative;67;67;67;66;65;67;65;65;71;65 20:08:56 INFO - PROCESS | 26812 | __end_tp_report 20:08:56 INFO - PROCESS | 26812 | __start_cc_report 20:08:56 INFO - PROCESS | 26812 | _x_x_mozilla_cycle_collect,664 20:08:56 INFO - PROCESS | 26812 | __end_cc_report 20:08:56 INFO - PROCESS | 26812 | __startTimestamp1457150936326__endTimestamp 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | ------- Summary: start ------- 20:08:56 INFO - PROCESS | 26812 | Number of tests: 14 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:3.72 (3.3%) stddev-sans-first:3.94 20:08:56 INFO - PROCESS | 26812 | Values: 114.0 107.0 113.0 112.0 113.0 122.0 112.0 114.0 112.0 115.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:156.00 stddev:14.29 (9.2%) stddev-sans-first:13.80 20:08:56 INFO - PROCESS | 26812 | Values: 166.0 142.0 159.0 162.0 130.0 153.0 153.0 131.0 164.0 132.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:1.97 (1.2%) stddev-sans-first:1.96 20:08:56 INFO - PROCESS | 26812 | Values: 163.0 164.0 166.0 163.0 167.0 163.0 165.0 163.0 168.0 167.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#3] audio-fft Cycles:10 Average:92.30 Median:76.50 stddev:33.65 (44.0%) stddev-sans-first:35.39 20:08:56 INFO - PROCESS | 26812 | Values: 80.0 74.0 77.0 158.0 78.0 76.0 75.0 73.0 154.0 78.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:97.00 stddev:19.08 (19.7%) stddev-sans-first:19.85 20:08:56 INFO - PROCESS | 26812 | Values: 98.0 96.0 137.0 97.0 97.0 97.0 137.0 96.0 97.0 135.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#5] imaging-gaussian-blur Cycles:10 Average:111.30 Median:111.00 stddev:1.77 (1.6%) stddev-sans-first:1.86 20:08:56 INFO - PROCESS | 26812 | Values: 112.0 111.0 116.0 110.0 111.0 111.0 110.0 111.0 111.0 110.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 20:08:56 INFO - PROCESS | 26812 | Values: 149.0 150.0 149.0 149.0 150.0 147.0 148.0 149.0 149.0 147.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:97.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 20:08:56 INFO - PROCESS | 26812 | Values: 97.0 96.0 98.0 96.0 97.0 97.0 100.0 100.0 97.0 97.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.85 (5.1%) stddev-sans-first:2.92 20:08:56 INFO - PROCESS | 26812 | Values: 54.0 56.0 56.0 55.0 55.0 58.0 57.0 63.0 53.0 54.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 20:08:56 INFO - PROCESS | 26812 | Values: 65.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.83 (2.2%) stddev-sans-first:1.92 20:08:56 INFO - PROCESS | 26812 | Values: 83.0 81.0 81.0 82.0 81.0 87.0 82.0 81.0 83.0 82.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:123.50 stddev:4.58 (3.7%) stddev-sans-first:4.84 20:08:56 INFO - PROCESS | 26812 | Values: 122.0 124.0 114.0 115.0 124.0 115.0 123.0 127.0 124.0 121.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.00 stddev:5.53 (4.0%) stddev-sans-first:5.66 20:08:56 INFO - PROCESS | 26812 | Values: 143.0 134.0 143.0 132.0 138.0 141.0 149.0 138.0 139.0 131.0 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - PROCESS | 26812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 20:08:56 INFO - PROCESS | 26812 | Values: 67.0 67.0 67.0 66.0 65.0 67.0 65.0 65.0 71.0 65.0 20:08:56 INFO - PROCESS | 26812 | -------- Summary: end -------- 20:08:56 INFO - PROCESS | 26812 | 20:08:56 INFO - TEST-INFO | 26812: exit 0 20:08:57 INFO - TEST-OK | kraken | took 57482ms 20:08:57 INFO - TEST-START | v8_7 20:08:57 INFO - operating with platform_type : linux_ 20:08:57 INFO - Initialising browser for v8_7 test... 20:08:57 INFO - TEST-INFO | started process 27105 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXk8TSc/profile http://localhost:33008/getInfo.html) 20:09:00 INFO - PROCESS | 27105 | 20:09:00 INFO - PROCESS | 27105 | (process:27187): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:01 INFO - PROCESS | 27105 | __metrics Screen width/height:1600/1200 20:09:01 INFO - PROCESS | 27105 | colorDepth:24 20:09:01 INFO - PROCESS | 27105 | Browser inner width/height: 1024/697 20:09:01 INFO - PROCESS | 27105 | __metrics 20:09:02 INFO - TEST-INFO | 27105: exit 0 20:09:02 INFO - Browser initialized. 20:09:02 INFO - Running cycle 1/1 for v8_7 test... 20:09:02 INFO - TEST-INFO | started process 27236 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXk8TSc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:03 INFO - PROCESS | 27236 | 20:09:03 INFO - PROCESS | 27236 | (process:27300): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:13 INFO - PROCESS | 27236 | RSS: Main: 141406208 20:09:13 INFO - PROCESS | 27236 | 20:09:35 INFO - PROCESS | 27236 | Cycle 1(1): loaded http://localhost:33008/tests/v8_7/run.html (next: http://localhost:33008/tests/v8_7/run.html) 20:09:36 INFO - PROCESS | 27236 | RSS: Main: 144723968 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | __start_tp_report 20:09:36 INFO - PROCESS | 27236 | _x_x_mozilla_page_load 20:09:36 INFO - PROCESS | 27236 | _x_x_mozilla_page_load_details 20:09:36 INFO - PROCESS | 27236 | |i|pagename|runs| 20:09:36 INFO - PROCESS | 27236 | |0;Richards;170.06802721088437 20:09:36 INFO - PROCESS | 27236 | |1;DeltaBlue;170.53206002728513 20:09:36 INFO - PROCESS | 27236 | |2;Encrypt;283.4467120181406 20:09:36 INFO - PROCESS | 27236 | |3;Decrypt;5319.148936170212 20:09:36 INFO - PROCESS | 27236 | |4;RayTrace;953.2888465204957 20:09:36 INFO - PROCESS | 27236 | |5;Earley;559.2841163310962 20:09:36 INFO - PROCESS | 27236 | |6;Boyer;11443.181818181818 20:09:36 INFO - PROCESS | 27236 | |7;RegExp;41122.448979591834 20:09:36 INFO - PROCESS | 27236 | |8;Splay;514.9330587023687 20:09:36 INFO - PROCESS | 27236 | |9;NavierStokes;4901.9607843137255 20:09:36 INFO - PROCESS | 27236 | __end_tp_report 20:09:36 INFO - PROCESS | 27236 | __startTimestamp1457150976073__endTimestamp 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | ------- Summary: start ------- 20:09:36 INFO - PROCESS | 27236 | Number of tests: 10 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#0] Richards Cycles:1 Average:170.07 Median:170.07 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 170.1 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#1] DeltaBlue Cycles:1 Average:170.53 Median:170.53 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 170.5 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 283.4 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#3] Decrypt Cycles:1 Average:5319.15 Median:5319.15 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 5319.1 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#4] RayTrace Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 953.3 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#5] Earley Cycles:1 Average:559.28 Median:559.28 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 559.3 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#6] Boyer Cycles:1 Average:11443.18 Median:11443.18 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 11443.2 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#7] RegExp Cycles:1 Average:41122.45 Median:41122.45 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 41122.4 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#8] Splay Cycles:1 Average:514.93 Median:514.93 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 514.9 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - PROCESS | 27236 | [#9] NavierStokes Cycles:1 Average:4901.96 Median:4901.96 stddev:0.00 (0.0%) 20:09:36 INFO - PROCESS | 27236 | Values: 4902.0 20:09:36 INFO - PROCESS | 27236 | -------- Summary: end -------- 20:09:36 INFO - PROCESS | 27236 | 20:09:36 INFO - TEST-INFO | 27236: exit 0 20:09:36 INFO - TEST-OK | v8_7 | took 39734ms 20:09:36 INFO - SUITE-END | took 1204s 20:09:37 INFO - Completed test suite (00:20:04) 20:09:37 INFO - Working with test: dromaeo_css 20:09:37 INFO - Generating results file: dromaeo_css 20:09:37 INFO - Working with test: kraken 20:09:37 INFO - Generating results file: kraken 20:09:37 INFO - javascript benchmark 20:09:37 INFO - Working with test: v8_7 20:09:37 INFO - Generating results file: v8_7 20:09:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 20:09:37 INFO - process_Request line: dromaeo_css 7168.87 graph.html#tests=[[72,52,43]] 20:09:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:37 INFO - process_Request line: kraken 1515.40 graph.html#tests=[[232,52,43]] 20:09:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:37 INFO - process_Request line: v8_7 21671.48 graph.html#tests=[[230,52,43]] 20:09:37 INFO - RETURN: dromaeo_css: 7168.87 20:09:37 INFO - RETURN: kraken: 1515.40 20:09:37 INFO - RETURN: v8_7: 21671.48 20:09:37 INFO - javascript benchmark 20:09:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3275.377678241134, 3292.522584225289, 3302.24048468852, 3330.5170750241214, 3337.5327454156413, 5286.995470860538, 5287.709175995319, 5319.574434045277, 5327.0943939530225, 5366.409694933554, 5365.651232669874, 5383.569314454844, 5396.352437707481, 5403.0, 5409.702466364349, 4873.195922672764, 4939.728314942677, 4948.925766113512, 4963.205887058071, 5069.771860266297, 4697.6241900647865, 4825.806967721287, 4875.902481950359, 4916.631252656047, 4997.375328083989, 4903.8774030649165, 4938.407391113072, 4958.975205123969, 4968.627352948525, 4995.025969935864, 4901.019796040806, 4907.1657818171, 4925.852224433273, 4927.408710954673, 4928.43323017854, 4737.384140061805, 4829.203181475053, 4838.782254798542, 4846.0550192712435, 4913.680610760325, 5069.873253168664, 5103.897922041576, 5121.103806833789, 5150.665206761549, 5178.275041494194, 5707.286589176353, 5748.65508069513, 5749.913751293692, 5756.7985120521, 5766.365699773021, 5603.635763675348, 5696.800611978602, 5719.14212868069, 5747.453991870766, 5828.795992140254, 5346.091164502044, 5386.165144402624, 5396.514313711785, 5397.73011349431, 5397.811076612339, 5837.474627283565, 5838.2702162229725, 5839.386864379264, 5860.472557469848, 5862.824115276549, 5474.945250547523, 5560.193771903051, 5570.749316280777, 5606.831795046155, 5619.0, 5755.3381361143165, 5759.740811663485, 5764.193012978187, 5771.220885180531, 5791.276090488689, 5509.807156749494, 5703.201551782754, 5738.282714660668, 5739.569532285095, 5781.479666830005, 5539.695316757617, 5631.099024156116, 5636.154576813511, 5650.26546548946, 5725.2843394575675, 4358.738475691469, 4391.187630288407, 4393.890152746207, 4406.052698669737, 4436.800343984529, 3819.083419979185, 3969.8412063517712, 3977.0455090778005, 3978.42312864633, 3997.480327557399, 5290.259363689087, 5335.706536140549, 5439.075357189287, 5480.205370221375, 5500.532454741312, 5702.6863522506665, 5771.567132465082, 5780.306363236355, 5782.277215348082, 5787.826365209051, 5255.710935898563, 5407.783688652488, 5487.204355368449, 5509.47659972302, 5526.917096243559, 4780.115678599401, 4805.8558243252755, 4876.634252431082, 4893.584045356113, 4971.651984361132, 5862.413758624103, 5958.404159584007, 5966.343702192756, 5969.2240008799445, 5981.850453738692, 5592.916106258328, 5671.801486948102, 5744.965906136768, 5857.502112320415, 5883.058710606454, 5851.1515830205235, 5856.970715146397, 5905.232319798399, 5906.173135761082, 5917.5857689961285, 5676.091825307931, 5691.288588926384, 5694.003549378925, 5697.430256974435, 5697.943020569741, 5571.832845014656, 5610.49505544503, 5632.605717599728, 5738.483536481736, 5743.310802703702, 5599.0, 5630.380658127685, 5674.007048766532, 5675.460831221028, 5680.091185410314, 5627.43725627434, 5635.239242702347, 5640.717964101696, 5648.209250704823, 5652.745626446737, 5322.042032434199, 5466.043442397644, 5474.972625136849, 5479.780808767605, 5500.1749737539685, 5563.805266815642, 5627.465390787868, 5665.830025099253, 5693.146028095819, 5706.087026075808, 5545.833624991256, 5560.972195138998, 5561.082421400585, 5561.499465048165, 5564.888702226014], "unit": "score", "name": "dojo.html", "value": 5289.485050209641}, {"lowerIsBetter": false, "replicates": [481.3117242343452, 532.3691425660592, 561.7472137538108, 582.2779753106147, 608.4280776070497, 30329.0, 37311.62688373119, 37966.8101659492, 38108.61891381082, 38147.23705525895, 40601.796991015006, 40853.0, 40925.59074409255, 40995.59004409955, 41123.17753644925, 8535.957320213405, 8717.215450609443, 8726.171013753716, 8735.825283494327, 8743.650253989832, 8461.703840365588, 8552.059273479912, 8565.186307300797, 8591.699290524833, 8606.5696715164, 8615.052344242129, 8899.911000890006, 8907.866382004275, 8908.643654253821, 8934.865977010317, 8755.562221888911, 8818.20636142747, 8842.690505832297, 8852.468851868909, 8866.601002954818, 8708.0, 8750.606222719993, 8801.823963520757, 8864.42381245217, 8870.112988701143, 40917.38623920643, 41403.171936561404, 41507.0, 41511.7924410376, 41544.37683434751, 3315.635280119185, 3350.6481819408855, 3378.121688361019, 3523.119220194951, 3874.3607304794673, 30962.690373096208, 31015.0, 31099.37801243985, 31676.0, 31739.0, 4184.079502509473, 4245.341971994346, 4309.978450107761, 4339.370791235285, 4345.869623911288, 280379.0, 282609.0, 283151.0, 284765.0, 334338.99999999756, 59280.11079833806, 59548.40451595429, 59817.10274345888, 59945.0, 59970.0, 62978.37021629725, 63353.0, 63360.36639633545, 63563.364366355745, 63647.0, 17929.641407171785, 17995.370162044266, 18015.909920450576, 18037.549061273574, 18197.27210911575, 14073.577792666236, 14395.928020360041, 14649.633759156106, 14691.338889749986, 14776.852231477762, 18922.62154756897, 21146.788532114482, 21670.78329216719, 21691.24080657201, 21699.132034718434, 8321.251087402163, 8740.519271440005, 8767.772511848347, 8806.207441330183, 8855.203031727175, 1044.6030508406757, 1141.2353723005606, 1163.66253786401, 1255.9058070644737, 1257.283348491351, 30028.399432011236, 32119.197020074218, 34341.484877726856, 34628.30743385169, 34662.48006279908, 1114.1922106472905, 1133.3200079951962, 1151.844500992372, 1170.0464121740754, 1203.975920481603, 14710.55868323952, 14745.92627036858, 14994.925025374803, 15129.924350378398, 15327.846721532866, 384737.0, 512362.0, 528447.0, 530925.0, 826996.0, 53668.73165634147, 53785.0, 54118.0, 54276.0, 54586.45413545893, 1465.0, 1489.2256026865969, 1493.6340596553914, 1508.4720347878156, 1508.5398953319122, 29825.25436864096, 30748.0, 31119.688803112585, 31867.840660796548, 31896.36207275795, 46038.539614604764, 46632.30051549297, 46640.0, 46697.766511168586, 46861.18832870039, 303215.0, 304090.0, 304233.0, 304427.0, 304793.0, 32858.835705822275, 33688.82089126869, 33734.15664608405, 33848.66151338554, 34055.148621284665, 42739.78630106829, 43465.78267108644, 43525.34711979386, 44028.77985610051, 44451.77774111109, 38193.42709859299, 38419.231615366974, 38986.4152037714, 39096.2180756389, 39335.803320984356, 40339.0, 41728.3740743883, 41892.581074190086, 42281.154376912906, 42415.7879210602, 37013.81493092625, 37171.07072323214, 37268.254634907695, 42186.57813421949, 42414.5758542423, 31850.36299274048, 32813.83593082019, 34317.48523772195, 34412.48381274233, 39623.40564891471, 26957.0, 27481.86259068692, 27588.6889974153, 27632.0, 27876.72123278741], "unit": "score", "name": "ext.html", "value": 19838.569365432988}, {"lowerIsBetter": false, "replicates": [382.59968515234266, 384.21236465246244, 385.8239529056123, 387.29705584364376, 387.79640688638443, 15701.450449234278, 17038.636909047276, 18746.62506749864, 18798.0, 19306.517337066547, 11151.107911367071, 11295.548178072868, 11470.483828227729, 17037.659246815056, 17424.3030278789, 4984.501549845023, 5220.347456567929, 5221.71280579568, 5262.868428289305, 5283.313169287987, 5138.66598671087, 5362.0616392131415, 5548.0, 5594.272744543204, 5635.619273278053, 5524.226608274845, 5572.86067848303, 5595.916061259064, 5651.632643878155, 6209.968950155243, 6125.111858780452, 6132.540059495555, 6143.10924915887, 6145.324014358417, 6163.784267550636, 5294.788208471657, 5459.372172200208, 5465.207544906006, 5475.397706252309, 5544.334679838405, 13052.0, 13117.212967221902, 20271.79728202714, 21236.0, 21245.78754212469, 2124.9787502124937, 2197.604431202383, 2197.923072692448, 2297.529006553669, 2414.806815454777, 9397.342186046979, 9647.179989700884, 9733.270004749673, 10023.548940297704, 13208.33958302081, 1870.9438716838517, 1917.3289348727974, 1923.9615207695908, 1924.8460123190112, 1925.9422217333502, 60356.39643603552, 60380.69809650967, 61279.693601531704, 61501.38498615001, 62321.37678623247, 10738.624148154777, 10768.78462430747, 10806.621768238074, 10810.0, 10884.891151088388, 12911.806322905164, 13946.790798138036, 13981.11254980585, 14078.296085195903, 14097.942654300969, 6392.4246817786625, 6627.403533681992, 7866.881996770053, 8266.297364723945, 8299.95850020746, 7958.08482024563, 7963.800904977422, 7991.360691144694, 8005.239502247277, 8019.719309824128, 4466.173757854807, 4642.280446530793, 4678.742669153161, 4685.835995740133, 4719.4100737407825, 1947.4060411574324, 1957.168203513501, 1982.4350060232764, 1984.2261518007988, 1984.7221389005551, 443.9223135951196, 456.5617007672605, 995.4723996281982, 1013.6604237580345, 1075.7794652096459, 10871.347719136877, 11409.771804564029, 11509.654710358702, 11514.654560363202, 11544.653660390202, 476.3949783774587, 489.24411783794125, 500.8497450764756, 501.6237821633775, 974.6637410093506, 7469.439792015621, 9416.834586916126, 9418.0, 9458.196053335407, 9726.027397260359, 574690.0, 582624.0, 588591.0, 589640.0, 608822.0, 65966.34033659603, 67096.32903670998, 69050.65474672595, 77010.61494692603, 78567.0, 1145.0953746540306, 1187.6674531131298, 1193.2184419205435, 1202.6091520255952, 1238.8637249902683, 16125.516234512983, 16186.028838269742, 16295.51113466598, 16383.426580069641, 16452.177391130157, 33446.498302525, 34076.31847363088, 34094.48858267078, 35112.0, 35606.643933560335, 43780.78109609432, 43832.342514861666, 44247.33628995632, 44597.77701111474, 45535.54464455446, 7202.855942881009, 7494.175640679412, 7750.341220996053, 7763.456558040883, 7771.261730135628, 10388.688339349832, 10835.729106772078, 10959.452027398758, 11182.776344473228, 11328.32030078198, 10504.527296271839, 10547.683569492927, 10577.100946419641, 10718.0, 10874.238803283693, 9636.22910167171, 9691.70924872255, 9877.456739879088, 10284.897151028394, 10689.9465502672, 9608.327417080738, 9796.510174491104, 10072.899271007489, 10272.435016074187, 10731.141508679131, 7811.921880781119, 8003.719869804529, 8031.879521807061, 8064.072631647436, 8073.475224110649, 9543.952280238833, 10091.142252908585, 10161.898381016095, 10190.082892539707, 10224.693259202237], "unit": "score", "name": "jquery.html", "value": 8228.36262661346}, {"lowerIsBetter": false, "replicates": [1540.6687562174134, 1556.859882610565, 1758.3933542927693, 1845.8154184581535, 1874.4470381237534, 7603.201663825294, 7656.617169141548, 7815.6873725051, 7828.725994590191, 7879.763607091789, 7869.80325491863, 7889.763307100782, 7980.680772769082, 7989.280964713174, 8000.439969202158, 2321.791038806507, 2338.590746619335, 2340.169239919821, 2341.4497593065616, 2349.6123139682018, 2373.774491423312, 2383.9880800595975, 2392.126873691099, 2399.892004859777, 2409.2410890569504, 2275.1923067311113, 2284.166279308049, 2331.743508214095, 2332.4518738096535, 2343.6367363058666, 2319.257837492003, 2346.683197768305, 2359.917402890899, 2361.7638236176244, 2364.47981444082, 2320.1879342230254, 2345.155743932183, 2349.6592994015773, 2350.106959355434, 2356.7171939367213, 7886.605669716491, 7915.366770658334, 7933.72231971884, 7934.206579342077, 7965.123836377994, 4869.488703686097, 4931.186354251544, 4967.528084831935, 4974.527419895104, 5003.574696150831, 3098.1634958561062, 3216.9195770105703, 3254.332861763333, 3262.429074911881, 3276.934461310784, 1117.017025017979, 1117.5027112934747, 1119.283658458587, 1121.6130434999911, 1122.343429093981, 10730.0, 10738.140948724084, 10760.946195268974, 10761.139108871272, 10831.783364332668, 4330.458692663417, 4357.956420435755, 4406.62543683784, 4473.776311184428, 4484.865454036384, 8721.825563488821, 8727.65089396417, 8744.956275218583, 8752.956235218782, 8760.08019157992, 4857.052874689472, 4888.9755551222015, 4911.68074075184, 4913.87715307113, 4920.827771027997, 4442.2892337225885, 4457.041736026705, 4480.126375356775, 4502.752348620857, 4530.139273538017, 3490.1449144959647, 3572.8034958077037, 3576.5171701819922, 3585.4442561403025, 3596.496490491333, 1022.5296363672645, 1035.1201478743008, 1036.4972988100765, 1073.5705717712976, 1078.7896360209684, 1136.9829452558217, 1141.9486123124314, 1182.4206138991833, 1357.8710022547841, 1413.8162038934872, 7232.783016509513, 7358.227386124487, 7419.035525381666, 7422.740204092939, 7438.070241219848, 1142.6229344316355, 1162.6686394377562, 1193.498730533178, 1195.647284051207, 1202.6331968749441, 5986.940130598726, 6004.099385092271, 6019.187409699722, 6031.4270144336215, 6031.849203769941, 8927.553622318857, 9381.718548443558, 9469.857952130724, 9552.092551207625, 9555.856662150074, 9301.72094837156, 9368.718938431857, 9383.812323753487, 9406.623735050658, 9433.339666223435, 7203.207647158808, 7425.108986921604, 7499.400047996147, 7515.436342274351, 7568.281013303727, 7127.786166415016, 7134.108236470442, 7142.5724023837565, 7217.133943926762, 7217.6391180441815, 8231.38264630167, 8279.089300176855, 8416.663333466593, 8574.27118694918, 8598.484090954562, 8374.958125209336, 8755.562221889008, 8843.867341989746, 8844.071372506052, 8867.0, 6676.298988606321, 6760.391564759196, 6783.423409010289, 6788.083608712761, 6791.524593278621, 7213.0, 7267.055282813412, 7273.672684729094, 7274.30894065063, 7319.268073192638, 7069.363757261665, 7217.06178196831, 7226.277372262732, 7270.890936635848, 7302.0142280791415, 6300.495960323255, 6893.827654308482, 6920.446364290945, 6941.861162776817, 6995.265497122728, 6929.44564434834, 7002.089728335284, 7030.543014704028, 7049.471289653399, 7093.113360829896, 6413.422791948747, 6450.741970321134, 6468.288488266193, 6479.967600161969, 6485.902711459237, 6438.484921206198, 6513.120728701565, 6515.218173818982, 6648.202215734143, 6667.833304167435], "unit": "score", "name": "mootools.html", "value": 4573.858464392571}, {"lowerIsBetter": false, "replicates": [360.3783473508197, 364.382371879664, 364.4660572261636, 373.46407904656826, 379.3816079789942, 6288.213973253343, 6288.905666414996, 6294.05589161626, 6309.873802523953, 6425.518086143535, 6177.81466556004, 6297.2128483939505, 6317.084022816689, 6351.523635727316, 6354.0786585945125, 4761.357216775726, 4776.976115119428, 4797.088553174885, 4800.399950006249, 4808.567228949394, 4749.216379297429, 4776.976115119437, 4778.259369797687, 4785.593224575915, 4809.941812801196, 4613.1696294666945, 4748.097861406339, 4760.8333708320215, 4765.380500534926, 4784.354112194861, 4741.668083234175, 4746.881327966794, 4755.072760811643, 4758.928616070762, 4767.785449654774, 4122.835086596532, 4124.876253712393, 4129.091599848029, 4136.276151673475, 4139.958600413987, 5992.79025234119, 6010.519158467312, 6015.819525414245, 6015.947209238366, 6036.667983260919, 5391.649542779707, 5505.724713764336, 5508.14623733322, 5512.6692398456225, 5526.530244929186, 6622.801315960529, 6648.734050637969, 6654.13496245485, 6658.833529161761, 6691.531592788507, 4483.887902802423, 4498.370228168026, 4522.050369422425, 4527.139843429771, 4529.614982726473, 6776.898346524806, 6869.313068693091, 6944.1666999959825, 6960.199577048603, 6960.65196740161, 4745.572898439157, 4758.42898852133, 4778.880527986758, 4812.975935120302, 4821.397325334333, 4798.1123492154065, 4875.24433712775, 4889.877753056202, 4889.951100488949, 4900.995295964319, 5525.557955363642, 5549.972250138723, 5567.832965011056, 5579.944200558024, 5592.692401917852, 6584.8024559263295, 6715.925451927766, 6716.429103526158, 6727.260001399842, 6733.158355205599, 1651.6036151323835, 1704.233095107182, 1710.9315627375015, 1712.0070359191639, 1715.3395942561954, 1150.6317978247048, 1151.3552410650063, 1157.1379322404694, 1158.0446131941183, 1163.1218430085232, 6350.682465876687, 6363.681815909186, 6455.967720161463, 6469.547131700736, 6500.5449618526245, 6859.862802743917, 6879.931200688029, 6927.3419025192525, 6936.7572134975035, 6959.88641817317, 6402.583832050902, 6441.420272175433, 6456.741730330828, 6461.386168314003, 6494.4479719223455, 3751.2309976454762, 3752.4746535485056, 3767.5102236709054, 3769.6041915599017, 3777.660010599004, 7084.858302834017, 7087.7164913402885, 7131.643417829087, 7141.571505709674, 7143.9642801786695, 6894.13823272091, 7087.015635622034, 7109.8933515997305, 7116.466265030143, 7125.1093613298335, 7059.470539709439, 7080.256573059857, 7101.715931362791, 7101.786946391617, 7117.145942486831, 6894.482913781386, 6900.378965893094, 6900.723971041102, 6925.792226233221, 6926.44588432914, 6669.699863506251, 6792.864142717217, 6799.0, 6823.0, 6849.863002739818, 7074.893876591752, 7093.113360829896, 7106.467014973794, 7119.466040046914, 7129.322714342129, 4792.281157826354, 4796.232602783538, 4807.990322032272, 4815.855524334275, 4828.66199366041, 6832.555883867532, 6880.58716477013, 6891.241963383924, 6898.551594146365, 6921.169459664872, 6673.8998915015345, 6683.331666833278, 6689.862723336947, 6692.83267918306, 6710.765123220664, 6646.0, 6677.332266773284, 6684.0642310075655, 6699.799006029827, 6718.865622687616, 6414.903776443264, 6542.280349161683, 6551.115599394021, 6554.901676474761, 6579.901301480578, 6651.035599838093, 6673.9332606673315, 6682.9331706682315, 6699.564528305645, 6719.428848547928, 6518.794023105741, 6520.021996700533, 6579.078928950046, 6598.208215014229, 6609.173853268341], "unit": "score", "name": "prototype.html", "value": 5043.399643945115}, {"lowerIsBetter": false, "replicates": [768.3660979691753, 785.897833281674, 807.8061265296329, 852.028687296482, 894.1282249806435, 14497.130172189663, 14649.633759156, 14663.0, 14688.706225875476, 14716.77924831127, 12074.577389791359, 12079.637610871667, 12102.09234307426, 12136.0, 12179.33013684247, 859.1751918158544, 867.4665080975186, 889.4974339498195, 891.6433426629335, 898.9505577193285, 895.1451363947447, 895.9830592277779, 898.0435835834847, 900.4372267332917, 900.4597241654988, 940.6378544260475, 943.4150826487553, 944.0276515189366, 944.6079876851098, 947.3889341374809, 924.3852837862813, 924.708716754227, 931.5528546297782, 936.1013427109982, 938.141600435604, 683.3917813146304, 684.9520533562653, 685.4345165238698, 685.8251145957798, 687.8589889072728, 15520.92239538795, 15562.37750489979, 15562.37750489979, 15577.376904923904, 15646.0, 13698.863011369858, 13790.65523361924, 13835.861641383557, 13842.861571384257, 13846.100003499841, 11402.71493212668, 11543.96104350604, 11549.94225028878, 11557.364344961024, 11852.288862668267, 3856.768593884376, 3860.1507668312925, 3860.6718428933573, 3902.609739026103, 3919.490466239399, 51338.48661513374, 51496.0, 53620.73189634066, 53808.99999999961, 53933.46066539363, 10431.530581123867, 10590.576376944837, 11060.115190784718, 11083.612073577386, 11092.0, 19296.903515482612, 19311.227550897805, 19319.613607727766, 19320.4203873884, 19405.902970485058, 8092.676292948334, 8311.542865142354, 8357.540335281496, 8370.372222083368, 8394.076651568323, 4694.624430045588, 4730.479647238801, 4793.736344501016, 4933.950660493421, 4953.975230123826, 3339.1652086978256, 3396.0, 3406.131436483681, 3412.982935085309, 3413.7269018478464, 591.8490784849836, 593.9435753603401, 602.4878852975024, 604.1843511259764, 606.3633185155569, 617.8756798370856, 662.2847324889108, 681.9727210911607, 703.0508813102373, 712.0885266858429, 9105.81788364229, 9515.666951656658, 9544.0, 9617.663381781604, 9627.374220675634, 604.6976511744128, 635.9951276982357, 716.7992961970657, 729.824842037907, 754.8867669849457, 4348.695591308578, 4424.247877860771, 4490.506044335186, 4695.600873925686, 4729.763511824395, 54060.0, 54929.0, 55035.72482137644, 55106.0, 55912.89263056916, 49501.50498495041, 49564.50435495671, 50005.49994500081, 50157.74921125444, 51814.22278665823, 47234.0, 49764.75117624389, 50385.244221337445, 51300.0, 51414.48585514172, 9606.519674016132, 9702.029797020241, 9712.805743884941, 9776.26677999167, 9839.458829764431, 37035.444468332455, 37504.43743343907, 38585.42121868118, 38721.0, 38730.6126938727, 42064.78967605143, 44100.55899441093, 46006.0, 47015.0, 47215.055698886514, 11778.587749428729, 11902.880971190523, 11934.52261909514, 12012.399380030789, 12264.754704905674, 13080.672983175496, 13130.803037954629, 13221.735565288447, 13412.865871341162, 13919.582412527641, 12431.93784031074, 12487.31319777421, 12596.622101336974, 13195.274259915797, 13534.120282181626, 12064.819027714415, 12189.634310970685, 12471.812922806346, 12521.56174533887, 12639.494420223456, 11747.588834390755, 12194.573189938665, 12366.505339786308, 12627.305498197687, 12920.676983075498, 10264.230182736175, 10396.272260941661, 10417.9479102604, 10469.68590942273, 10824.134069274282, 10219.846702299621, 10794.136469082612, 10921.781564368826, 10941.617043403761, 10945.398003109905], "unit": "score", "name": "yui.html", "value": 6814.336325435454}], "name": "dromaeo_css", "value": 7168.871886907873}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 113.0, 112.0, 113.0, 122.0, 112.0, 114.0, 112.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [166.0, 142.0, 159.0, 162.0, 130.0, 153.0, 153.0, 131.0, 164.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 166.0, 163.0, 167.0, 163.0, 165.0, 163.0, 168.0, 167.0], "unit": "score", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 77.0, 158.0, 78.0, 76.0, 75.0, 73.0, 154.0, 78.0], "unit": "score", "name": "audio-fft", "value": 92.3}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 137.0, 97.0, 97.0, 97.0, 137.0, 96.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 116.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.3}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 149.0, 149.0, 150.0, 147.0, 148.0, 149.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 96.0, 97.0, 97.0, 100.0, 100.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.5}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 56.0, 55.0, 55.0, 58.0, 57.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 81.0, 82.0, 81.0, 87.0, 82.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 114.0, 115.0, 124.0, 115.0, 123.0, 127.0, 124.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 143.0, 132.0, 138.0, 141.0, 149.0, 138.0, 139.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 67.0, 65.0, 65.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1515.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.06802721088437], "unit": "score", "name": "Richards", "value": 207.57575999999992}, {"lowerIsBetter": false, "replicates": [170.53206002728513], "unit": "score", "name": "DeltaBlue", "value": 387.71595200000013}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [5319.148936170212], "unit": "score", "name": "Decrypt", "value": 50.04202800000001}, {"lowerIsBetter": false, "replicates": [953.2888465204957], "unit": "score", "name": "RayTrace", "value": 776.2484609999998}, {"lowerIsBetter": false, "replicates": [559.2841163310962], "unit": "score", "name": "Earley", "value": 1191.6358439999997}, {"lowerIsBetter": false, "replicates": [11443.181818181818], "unit": "score", "name": "Boyer", "value": 58.24105660377359}, {"lowerIsBetter": false, "replicates": [41122.448979591834], "unit": "score", "name": "RegExp", "value": 22.152985111662527}, {"lowerIsBetter": false, "replicates": [514.9330587023687], "unit": "score", "name": "Splay", "value": 158.25552199999996}, {"lowerIsBetter": false, "replicates": [4901.9607843137255], "unit": "score", "name": "NavierStokes", "value": 302.7359999999999}], "name": "v8_7", "value": 21671.483631025538}]} 20:09:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21671.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1515.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7168.87"}}} 20:09:37 INFO - Return code: 0 20:09:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:09:37 INFO - # TBPL SUCCESS # 20:09:37 INFO - Running post-action listener: _resource_record_post_action 20:09:37 INFO - Running post-run listener: _resource_record_post_run 20:09:38 INFO - Total resource usage - Wall time: 1221s; CPU: 25.0%; Read bytes: 266240; Write bytes: 501682176; Read time: 48; Write time: 558284 20:09:38 INFO - install - Wall time: 15s; CPU: 27.0%; Read bytes: 0; Write bytes: 241872896; Read time: 0; Write time: 361936 20:09:38 INFO - run-tests - Wall time: 1206s; CPU: 25.0%; Read bytes: 266240; Write bytes: 259809280; Read time: 48; Write time: 196348 20:09:38 INFO - Running post-run listener: _upload_blobber_files 20:09:38 INFO - Blob upload gear active. 20:09:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:09:38 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:09:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:09:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:09:38 INFO - (blobuploader) - INFO - Open directory for files ... 20:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:39 INFO - (blobuploader) - INFO - Done attempting. 20:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:40 INFO - (blobuploader) - INFO - Done attempting. 20:09:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:09:40 INFO - Return code: 0 20:09:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:09:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:09:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14856848c12ddce5c389f20417fdd15155e80337718575f8cac8d04498d5dbb5b42a31b8e328208df8398910d2b587135a1911a250f8d14f8c325ebd851f0adf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c00cabb41ab6ad337a96433c2ecdfce8771975330e27956770d5c8af3eb5c0b8b8394b945a4ee58fd2023fc470953033218d654ad26eee5b1eca6cd4d61531e"} 20:09:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:09:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:09:40 INFO - Contents: 20:09:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14856848c12ddce5c389f20417fdd15155e80337718575f8cac8d04498d5dbb5b42a31b8e328208df8398910d2b587135a1911a250f8d14f8c325ebd851f0adf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c00cabb41ab6ad337a96433c2ecdfce8771975330e27956770d5c8af3eb5c0b8b8394b945a4ee58fd2023fc470953033218d654ad26eee5b1eca6cd4d61531e"} 20:09:40 INFO - Running post-run listener: copy_logs_to_upload_dir 20:09:40 INFO - Copying logs to upload dir... 20:09:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:09:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.055979 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-03-04 20:09:40.114989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 20:09:40.118802) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14856848c12ddce5c389f20417fdd15155e80337718575f8cac8d04498d5dbb5b42a31b8e328208df8398910d2b587135a1911a250f8d14f8c325ebd851f0adf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c00cabb41ab6ad337a96433c2ecdfce8771975330e27956770d5c8af3eb5c0b8b8394b945a4ee58fd2023fc470953033218d654ad26eee5b1eca6cd4d61531e"} build_url:https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005496 build_url: 'https://queue.taskcluster.net/v1/task/TvkyPttLS82c_MAWBqMJ-A/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14856848c12ddce5c389f20417fdd15155e80337718575f8cac8d04498d5dbb5b42a31b8e328208df8398910d2b587135a1911a250f8d14f8c325ebd851f0adf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c00cabb41ab6ad337a96433c2ecdfce8771975330e27956770d5c8af3eb5c0b8b8394b945a4ee58fd2023fc470953033218d654ad26eee5b1eca6cd4d61531e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 20:09:40.133382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 20:09:40.133770) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1457149309.456468-1136486318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002217 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 20:09:40.215356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 20:09:40.215746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 20:09:40.216113) ========= ========= Total master_lag: 0.26 =========