builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1452646224.78 results: success (0) buildid: 20160112143012 builduid: c4f3f7f3e8a64e178d46642753563bb6 revision: dd328684ee1e46c94e0ce0988c641b18ef329f39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.781746) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.782194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.782482) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004524 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.831089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.831389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.883934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.884308) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038444 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.932822) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.933129) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.933890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:24.934187) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 16:50:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.5M=0s 2016-01-12 16:50:25 (32.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.299009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:25.245006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:25.245327) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055168 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:25.317910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 16:50:25.318230) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd328684ee1e46c94e0ce0988c641b18ef329f39 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dd328684ee1e46c94e0ce0988c641b18ef329f39 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 16:50:25,379 truncating revision to first 12 chars 2016-01-12 16:50:25,379 Setting DEBUG logging. 2016-01-12 16:50:25,379 attempt 1/10 2016-01-12 16:50:25,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd328684ee1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 16:50:26,281 unpacking tar archive at: fx-team-dd328684ee1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.225256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 16:50:26.557289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:26.557708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:26.566597) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:26.567151) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 16:50:26.567607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-12 16:50:26.567888) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:26 INFO - MultiFileLogger online at 20160112 16:50:26 in /builds/slave/test-pgo 16:50:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:50:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:50:26 INFO - {'append_to_log': False, 16:50:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:50:26 INFO - 'blob_upload_branch': 'Fx-Team', 16:50:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:50:26 INFO - 'branch': 'Fx-Team', 16:50:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:26 INFO - 'config_files': ('talos/linux_config.py',), 16:50:26 INFO - 'default_actions': ('clobber', 16:50:26 INFO - 'read-buildbot-config', 16:50:26 INFO - 'download-and-extract', 16:50:26 INFO - 'populate-webroot', 16:50:26 INFO - 'create-virtualenv', 16:50:26 INFO - 'install', 16:50:26 INFO - 'run-tests'), 16:50:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:26 INFO - 'download_minidump_stackwalk': True, 16:50:26 INFO - 'download_symbols': 'ondemand', 16:50:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:26 INFO - 'installer_path': 'installer.exe', 16:50:26 INFO - 'log_level': 'info', 16:50:26 INFO - 'log_name': 'talos', 16:50:26 INFO - 'log_to_console': True, 16:50:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:26 INFO - 'opt_config_files': (), 16:50:26 INFO - 'pip_index': False, 16:50:26 INFO - 'sps_profile': False, 16:50:26 INFO - 'sps_profile_interval': 0, 16:50:26 INFO - 'suite': 'dromaeojs-e10s', 16:50:26 INFO - 'system_bits': '32', 16:50:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:26 INFO - 'title': 'talos-linux64-ix-025', 16:50:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:26 INFO - 'use_talos_json': True, 16:50:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:50:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:26 INFO - 'work_dir': 'build'} 16:50:26 INFO - ##### 16:50:26 INFO - ##### Running clobber step. 16:50:26 INFO - ##### 16:50:26 INFO - Running pre-action listener: _resource_record_pre_action 16:50:26 INFO - Running main action method: clobber 16:50:26 INFO - rmtree: /builds/slave/test-pgo/build 16:50:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running read-buildbot-config step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: read_buildbot_config 16:50:27 INFO - Using buildbot properties: 16:50:27 INFO - { 16:50:27 INFO - "project": "", 16:50:27 INFO - "product": "firefox", 16:50:27 INFO - "script_repo_revision": "production", 16:50:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:50:27 INFO - "repository": "", 16:50:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:50:27 INFO - "buildid": "20160112143012", 16:50:27 INFO - "pgo_build": "True", 16:50:27 INFO - "basedir": "/builds/slave/test-pgo", 16:50:27 INFO - "buildnumber": 442, 16:50:27 INFO - "slavename": "talos-linux64-ix-025", 16:50:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:50:27 INFO - "platform": "ubuntu64_hw", 16:50:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:50:27 INFO - "branch": "fx-team", 16:50:27 INFO - "repo_path": "integration/fx-team", 16:50:27 INFO - "revision": "dd328684ee1e46c94e0ce0988c641b18ef329f39", 16:50:27 INFO - "stage_platform": "linux64-pgo", 16:50:27 INFO - "builduid": "c4f3f7f3e8a64e178d46642753563bb6", 16:50:27 INFO - "slavebuilddir": "test" 16:50:27 INFO - } 16:50:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running download-and-extract step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: download_and_extract 16:50:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:27 INFO - https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/test_packages.json 16:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/test_packages.json 16:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:50:31 INFO - Downloaded 1302 bytes. 16:50:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:50:31 INFO - Using the following test package requirements: 16:50:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'jsshell-linux-x86_64.zip'], 16:50:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50: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')]} 16:50:31 INFO - https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:33 INFO - Downloaded 24027118 bytes. 16:50:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:50:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:50:35 INFO - Return code: 0 16:50:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:35 INFO - https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:43 INFO - Downloaded 24027118 bytes. 16:50:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 16:50:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:50:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:50:45 INFO - Return code: 0 16:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:45 INFO - https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:47 INFO - Downloaded 11132285 bytes. 16:50:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 16:50:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:50:47 INFO - Return code: 0 16:50:47 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')]} 16:50:47 INFO - https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:50 INFO - Downloaded 55742049 bytes. 16:50:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:50 INFO - mkdir: /builds/slave/test-pgo/properties 16:50:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:50:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:50:50 INFO - Contents: 16:50:50 INFO - build_url:https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:50 INFO - Running post-action listener: _resource_record_post_action 16:50:50 INFO - Running post-action listener: set_extra_try_arguments 16:50:50 INFO - ##### 16:50:50 INFO - ##### Running populate-webroot step. 16:50:50 INFO - ##### 16:50:50 INFO - Running pre-action listener: _resource_record_pre_action 16:50:50 INFO - Running main action method: populate_webroot 16:50:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:50 INFO - '--tppagecycles', 16:50:50 INFO - '7'], 16:50:50 INFO - 'tests': ['tsvgm']}}, 16:50:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:50:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'tests': ['damp', 'tps']}, 16:50:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['damp', 'tps']}, 16:50:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:50:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:50 INFO - 'other': {'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'other_l64': {'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:50:50 INFO - 'ts_paint', 16:50:50 INFO - 'tpaint', 16:50:50 INFO - 'sessionrestore', 16:50:50 INFO - 'sessionrestore_no_auto_restore']}, 16:50:50 INFO - 'svgr': {'tests': ['tsvgx', 16:50:50 INFO - 'tsvgr_opacity', 16:50:50 INFO - 'tart', 16:50:50 INFO - 'tscrollx', 16:50:50 INFO - 'cart']}, 16:50:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['tsvgx', 16:50:50 INFO - 'tsvgr_opacity', 16:50:50 INFO - 'tart', 16:50:50 INFO - 'tscrollx', 16:50:50 INFO - 'cart']}, 16:50:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'tests': ['tp5o']}, 16:50:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'talos_options': ['--e10s'], 16:50:50 INFO - 'tests': ['tp5o']}, 16:50:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'talos_options': ['--xperf_path', 16:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:50 INFO - 'tests': ['tp5n']}, 16:50:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:50 INFO - 'talos_options': ['--e10s', 16:50:50 INFO - '--xperf_path', 16:50:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:50 INFO - 'tests': ['tp5n']}}, 16:50:50 INFO - 'talos.zip': {'path': '', 16:50:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:50 INFO - Running post-action listener: _resource_record_post_action 16:50:50 INFO - ##### 16:50:50 INFO - ##### Running create-virtualenv step. 16:50:50 INFO - ##### 16:50:50 INFO - Running pre-action listener: _resource_record_pre_action 16:50:50 INFO - Running main action method: create_virtualenv 16:50:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:50:50 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 16:50:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:50:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:50 INFO - Using real prefix '/usr' 16:50:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:50:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:53 INFO - Installing pip.................done. 16:50:53 INFO - Return code: 0 16:50:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:50:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:50:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:50:53 INFO - Using env: {'DISPLAY': ':0', 16:50:53 INFO - 'HOME': '/home/cltbld', 16:50:53 INFO - 'LANG': 'en_US.UTF-8', 16:50:53 INFO - 'LANGUAGE': 'en_US:en', 16:50:53 INFO - 'LOGNAME': 'cltbld', 16:50:53 INFO - 'MAIL': '/var/mail/cltbld', 16:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:53 INFO - 'MOZ_NO_REMOTE': '1', 16:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:53 INFO - 'NO_EM_RESTART': '1', 16:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:53 INFO - 'SHELL': '/bin/bash', 16:50:53 INFO - 'SHLVL': '1', 16:50:53 INFO - 'TERM': 'linux', 16:50:53 INFO - 'TMOUT': '86400', 16:50:53 INFO - 'USER': 'cltbld', 16:50:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:53 INFO - '_': '/tools/buildbot/bin/python'} 16:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:50:54 INFO - Cleaning up... 16:50:54 INFO - Return code: 0 16:50:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:50:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:50:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:50:54 INFO - Using env: {'DISPLAY': ':0', 16:50:54 INFO - 'HOME': '/home/cltbld', 16:50:54 INFO - 'LANG': 'en_US.UTF-8', 16:50:54 INFO - 'LANGUAGE': 'en_US:en', 16:50:54 INFO - 'LOGNAME': 'cltbld', 16:50:54 INFO - 'MAIL': '/var/mail/cltbld', 16:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:54 INFO - 'MOZ_NO_REMOTE': '1', 16:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:54 INFO - 'NO_EM_RESTART': '1', 16:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:54 INFO - 'SHELL': '/bin/bash', 16:50:54 INFO - 'SHLVL': '1', 16:50:54 INFO - 'TERM': 'linux', 16:50:54 INFO - 'TMOUT': '86400', 16:50:54 INFO - 'USER': 'cltbld', 16:50:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:54 INFO - '_': '/tools/buildbot/bin/python'} 16:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:54 INFO - Downloading/unpacking psutil>=0.7.1 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:50:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:50:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:56 INFO - Installing collected packages: psutil 16:50:56 INFO - Running setup.py install for psutil 16:50:56 INFO - building 'psutil._psutil_linux' extension 16:50:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:50:57 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 16:50:57 INFO - building 'psutil._psutil_posix' extension 16:50:57 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 16:50: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 16:50:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:58 INFO - Successfully installed psutil 16:50:58 INFO - Cleaning up... 16:50:58 INFO - Return code: 0 16:50:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:50:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:50:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:50:58 INFO - Using env: {'DISPLAY': ':0', 16:50:58 INFO - 'HOME': '/home/cltbld', 16:50:58 INFO - 'LANG': 'en_US.UTF-8', 16:50:58 INFO - 'LANGUAGE': 'en_US:en', 16:50:58 INFO - 'LOGNAME': 'cltbld', 16:50:58 INFO - 'MAIL': '/var/mail/cltbld', 16:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:58 INFO - 'MOZ_NO_REMOTE': '1', 16:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:58 INFO - 'NO_EM_RESTART': '1', 16:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:58 INFO - 'SHELL': '/bin/bash', 16:50:58 INFO - 'SHLVL': '1', 16:50:58 INFO - 'TERM': 'linux', 16:50:58 INFO - 'TMOUT': '86400', 16:50:58 INFO - 'USER': 'cltbld', 16:50:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:58 INFO - '_': '/tools/buildbot/bin/python'} 16:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:50: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 16:51:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:51:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:51:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51: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) 16:51:00 INFO - Installing collected packages: mozsystemmonitor 16:51:00 INFO - Running setup.py install for mozsystemmonitor 16:51:00 INFO - Successfully installed mozsystemmonitor 16:51:00 INFO - Cleaning up... 16:51:00 INFO - Return code: 0 16:51:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:51:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:00 INFO - Using env: {'DISPLAY': ':0', 16:51:00 INFO - 'HOME': '/home/cltbld', 16:51:00 INFO - 'LANG': 'en_US.UTF-8', 16:51:00 INFO - 'LANGUAGE': 'en_US:en', 16:51:00 INFO - 'LOGNAME': 'cltbld', 16:51:00 INFO - 'MAIL': '/var/mail/cltbld', 16:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:00 INFO - 'MOZ_NO_REMOTE': '1', 16:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:00 INFO - 'NO_EM_RESTART': '1', 16:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:00 INFO - 'SHELL': '/bin/bash', 16:51:00 INFO - 'SHLVL': '1', 16:51:00 INFO - 'TERM': 'linux', 16:51:00 INFO - 'TMOUT': '86400', 16:51:00 INFO - 'USER': 'cltbld', 16:51:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:00 INFO - '_': '/tools/buildbot/bin/python'} 16:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:02 INFO - Downloading docopt-0.6.1.tar.gz 16:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:51:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:03 INFO - Running setup.py install for blobuploader 16:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:51:03 INFO - Running setup.py install for requests 16:51:03 INFO - Running setup.py install for docopt 16:51:03 INFO - Successfully installed blobuploader requests docopt 16:51:03 INFO - Cleaning up... 16:51:03 INFO - Return code: 0 16:51:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:03 INFO - Using env: {'DISPLAY': ':0', 16:51:03 INFO - 'HOME': '/home/cltbld', 16:51:03 INFO - 'LANG': 'en_US.UTF-8', 16:51:03 INFO - 'LANGUAGE': 'en_US:en', 16:51:03 INFO - 'LOGNAME': 'cltbld', 16:51:03 INFO - 'MAIL': '/var/mail/cltbld', 16:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:03 INFO - 'MOZ_NO_REMOTE': '1', 16:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:03 INFO - 'NO_EM_RESTART': '1', 16:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:03 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:03 INFO - 'SHELL': '/bin/bash', 16:51:03 INFO - 'SHLVL': '1', 16:51:03 INFO - 'TERM': 'linux', 16:51:03 INFO - 'TMOUT': '86400', 16:51:03 INFO - 'USER': 'cltbld', 16:51:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:03 INFO - '_': '/tools/buildbot/bin/python'} 16:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:03 INFO - Running setup.py (path:/tmp/pip-uAOJ7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:03 INFO - Running setup.py (path:/tmp/pip-G4KpT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:03 INFO - Running setup.py (path:/tmp/pip-oWmreS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:04 INFO - Running setup.py (path:/tmp/pip-KE73Nt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:04 INFO - Running setup.py (path:/tmp/pip-IAfnFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:04 INFO - Running setup.py (path:/tmp/pip-qs748m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:04 INFO - Running setup.py (path:/tmp/pip-pVeqqP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:04 INFO - Running setup.py (path:/tmp/pip-q7tMSm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:04 INFO - Running setup.py (path:/tmp/pip-nZDdm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:04 INFO - Running setup.py (path:/tmp/pip-elwrJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:04 INFO - Running setup.py (path:/tmp/pip-0lzQNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:04 INFO - Running setup.py (path:/tmp/pip-VBtJby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:04 INFO - Running setup.py (path:/tmp/pip-7OzHAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:04 INFO - Running setup.py (path:/tmp/pip-RZ7TOC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:04 INFO - Running setup.py (path:/tmp/pip-JURxLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:04 INFO - Running setup.py (path:/tmp/pip-VstMaP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:04 INFO - Running setup.py (path:/tmp/pip-ABGpLR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:04 INFO - Running setup.py install for manifestparser 16:51:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Running setup.py install for mozcrash 16:51:05 INFO - Running setup.py install for mozdebug 16:51:05 INFO - Running setup.py install for mozdevice 16:51:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Running setup.py install for mozfile 16:51:05 INFO - Running setup.py install for mozhttpd 16:51:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Running setup.py install for mozinfo 16:51:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Running setup.py install for mozInstall 16:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:51:05 INFO - Running setup.py install for mozleak 16:51:05 INFO - Running setup.py install for mozlog 16:51:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Running setup.py install for moznetwork 16:51:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Running setup.py install for mozprocess 16:51:06 INFO - Running setup.py install for mozprofile 16:51:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Running setup.py install for mozrunner 16:51:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Running setup.py install for mozscreenshot 16:51:06 INFO - Running setup.py install for moztest 16:51:06 INFO - Running setup.py install for mozversion 16:51:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:06 INFO - Cleaning up... 16:51:06 INFO - Return code: 0 16:51:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:51:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:06 INFO - Using env: {'DISPLAY': ':0', 16:51:06 INFO - 'HOME': '/home/cltbld', 16:51:06 INFO - 'LANG': 'en_US.UTF-8', 16:51:06 INFO - 'LANGUAGE': 'en_US:en', 16:51:06 INFO - 'LOGNAME': 'cltbld', 16:51:06 INFO - 'MAIL': '/var/mail/cltbld', 16:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:06 INFO - 'MOZ_NO_REMOTE': '1', 16:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:06 INFO - 'NO_EM_RESTART': '1', 16:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:06 INFO - 'SHELL': '/bin/bash', 16:51:06 INFO - 'SHLVL': '1', 16:51:06 INFO - 'TERM': 'linux', 16:51:06 INFO - 'TMOUT': '86400', 16:51:06 INFO - 'USER': 'cltbld', 16:51:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:06 INFO - '_': '/tools/buildbot/bin/python'} 16:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51:07 INFO - Running setup.py (path:/tmp/pip-Ls3ihY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51:07 INFO - Running setup.py (path:/tmp/pip-MMCUkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51:07 INFO - Running setup.py (path:/tmp/pip-WUQpwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:07 INFO - Running setup.py (path:/tmp/pip-RTmRU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51:07 INFO - Running setup.py (path:/tmp/pip-wUbWFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51:07 INFO - Running setup.py (path:/tmp/pip-M9JwX2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51:07 INFO - Running setup.py (path:/tmp/pip-aFt0hU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51:07 INFO - Running setup.py (path:/tmp/pip-cTtTjd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51:07 INFO - Running setup.py (path:/tmp/pip-l8stqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51:07 INFO - Running setup.py (path:/tmp/pip-PZUXcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51:07 INFO - Running setup.py (path:/tmp/pip-4NaxW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51:07 INFO - Running setup.py (path:/tmp/pip-w6Cubl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51:07 INFO - Running setup.py (path:/tmp/pip-1a4QEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:51: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)) 16:51:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:07 INFO - Running setup.py (path:/tmp/pip-zUyayx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:51:08 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)) 16:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51:08 INFO - Running setup.py (path:/tmp/pip-SFmQTK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:51: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)) 16:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:51:08 INFO - Running setup.py (path:/tmp/pip-BfjbgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:51: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)) 16:51:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51:08 INFO - Running setup.py (path:/tmp/pip-Pb5_kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51: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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:09 INFO - Downloading blessings-1.5.1.tar.gz 16:51:09 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:51:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:10 INFO - Installing collected packages: blessings 16:51:10 INFO - Running setup.py install for blessings 16:51:10 INFO - Successfully installed blessings 16:51:10 INFO - Cleaning up... 16:51:10 INFO - Return code: 0 16:51:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:51:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:10 INFO - Reading from file tmpfile_stdout 16:51:10 INFO - Current package versions: 16:51:10 INFO - argparse == 1.2.1 16:51:10 INFO - blessings == 1.5.1 16:51:10 INFO - blobuploader == 1.2.4 16:51:10 INFO - docopt == 0.6.1 16:51:10 INFO - manifestparser == 1.1 16:51:10 INFO - mozInstall == 1.12 16:51:10 INFO - mozcrash == 0.16 16:51:10 INFO - mozdebug == 0.1 16:51:10 INFO - mozdevice == 0.47 16:51:10 INFO - mozfile == 1.2 16:51:10 INFO - mozhttpd == 0.7 16:51:10 INFO - mozinfo == 0.9 16:51:10 INFO - mozleak == 0.1 16:51:10 INFO - mozlog == 3.1 16:51:10 INFO - moznetwork == 0.27 16:51:10 INFO - mozprocess == 0.22 16:51:10 INFO - mozprofile == 0.28 16:51:10 INFO - mozrunner == 6.11 16:51:10 INFO - mozscreenshot == 0.1 16:51:10 INFO - mozsystemmonitor == 0.0 16:51:10 INFO - moztest == 0.7 16:51:10 INFO - mozversion == 1.4 16:51:10 INFO - psutil == 3.1.1 16:51:10 INFO - requests == 1.2.3 16:51:10 INFO - wsgiref == 0.1.2 16:51:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:51:10 INFO - Using env: {'DISPLAY': ':0', 16:51:10 INFO - 'HOME': '/home/cltbld', 16:51:10 INFO - 'LANG': 'en_US.UTF-8', 16:51:10 INFO - 'LANGUAGE': 'en_US:en', 16:51:10 INFO - 'LOGNAME': 'cltbld', 16:51:10 INFO - 'MAIL': '/var/mail/cltbld', 16:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:10 INFO - 'MOZ_NO_REMOTE': '1', 16:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:10 INFO - 'NO_EM_RESTART': '1', 16:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:10 INFO - 'SHELL': '/bin/bash', 16:51:10 INFO - 'SHLVL': '1', 16:51:10 INFO - 'TERM': 'linux', 16:51:10 INFO - 'TMOUT': '86400', 16:51:10 INFO - 'USER': 'cltbld', 16:51:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:10 INFO - '_': '/tools/buildbot/bin/python'} 16:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51: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)) 16:51:10 INFO - Cleaning up... 16:51:10 INFO - Return code: 0 16:51:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:51:10 INFO - Using env: {'DISPLAY': ':0', 16:51:10 INFO - 'HOME': '/home/cltbld', 16:51:10 INFO - 'LANG': 'en_US.UTF-8', 16:51:10 INFO - 'LANGUAGE': 'en_US:en', 16:51:10 INFO - 'LOGNAME': 'cltbld', 16:51:10 INFO - 'MAIL': '/var/mail/cltbld', 16:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:10 INFO - 'MOZ_NO_REMOTE': '1', 16:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:10 INFO - 'NO_EM_RESTART': '1', 16:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:10 INFO - 'SHELL': '/bin/bash', 16:51:10 INFO - 'SHLVL': '1', 16:51:10 INFO - 'TERM': 'linux', 16:51:10 INFO - 'TMOUT': '86400', 16:51:10 INFO - 'USER': 'cltbld', 16:51:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:10 INFO - '_': '/tools/buildbot/bin/python'} 16:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:10 INFO - Downloading/unpacking jsonschema 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:51:12 INFO - Downloading/unpacking functools32 (from jsonschema) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:51:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:12 INFO - warning: no files found matching '*.txt' 16:51:12 INFO - no previously-included directories found matching 'build' 16:51:12 INFO - no previously-included directories found matching 'dist' 16:51:12 INFO - no previously-included directories found matching '.git*' 16:51:12 INFO - Installing collected packages: jsonschema, functools32 16:51:12 INFO - Running setup.py install for functools32 16:51:12 INFO - warning: no files found matching '*.txt' 16:51:12 INFO - no previously-included directories found matching 'build' 16:51:12 INFO - no previously-included directories found matching 'dist' 16:51:12 INFO - no previously-included directories found matching '.git*' 16:51:13 INFO - Successfully installed jsonschema functools32 16:51:13 INFO - Cleaning up... 16:51:13 INFO - Return code: 0 16:51:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:51: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')]} 16:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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')]} 16:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6953d37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', '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 16:51:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:51:13 INFO - Using env: {'DISPLAY': ':0', 16:51:13 INFO - 'HOME': '/home/cltbld', 16:51:13 INFO - 'LANG': 'en_US.UTF-8', 16:51:13 INFO - 'LANGUAGE': 'en_US:en', 16:51:13 INFO - 'LOGNAME': 'cltbld', 16:51:13 INFO - 'MAIL': '/var/mail/cltbld', 16:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:13 INFO - 'MOZ_NO_REMOTE': '1', 16:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:13 INFO - 'NO_EM_RESTART': '1', 16:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:13 INFO - 'SHELL': '/bin/bash', 16:51:13 INFO - 'SHLVL': '1', 16:51:13 INFO - 'TERM': 'linux', 16:51:13 INFO - 'TMOUT': '86400', 16:51:13 INFO - 'USER': 'cltbld', 16:51:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:13 INFO - '_': '/tools/buildbot/bin/python'} 16:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:13 INFO - Downloading/unpacking flake8 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:51:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:51:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51: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 16:51:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:51:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:51:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 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 16:51:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:51:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:16 INFO - no previously-included directories found matching 'docs/_build' 16:51:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:51:16 INFO - Running setup.py install for pep8 16:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:51:16 INFO - no previously-included directories found matching 'docs/_build' 16:51:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:51:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:51:16 INFO - Cleaning up... 16:51:16 INFO - Return code: 0 16:51:16 INFO - Running post-action listener: _resource_record_post_action 16:51:16 INFO - Running post-action listener: _start_resource_monitoring 16:51:16 INFO - Starting resource monitoring. 16:51:16 INFO - ##### 16:51:16 INFO - ##### Running install step. 16:51:16 INFO - ##### 16:51:16 INFO - Running pre-action listener: _resource_record_pre_action 16:51:16 INFO - Running main action method: install 16:51:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:51:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:51:17 INFO - Reading from file tmpfile_stdout 16:51:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:51:17 INFO - Reading from file tmpfile_stdout 16:51:17 INFO - Output received: 16:51:17 INFO - Usage: mozinstall [options] installer 16:51:17 INFO - Options: 16:51:17 INFO - -h, --help show this help message and exit 16:51:17 INFO - -d DEST, --destination=DEST 16:51:17 INFO - Directory to install application into. [default: 16:51:17 INFO - "/builds/slave/test-pgo"] 16:51:17 INFO - --app=APP Application being installed. [default: firefox] 16:51:17 INFO - mkdir: /builds/slave/test-pgo/build/application 16:51:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:51:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:51:33 INFO - Reading from file tmpfile_stdout 16:51:33 INFO - Output received: 16:51:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:51:33 INFO - Running post-action listener: _resource_record_post_action 16:51:33 INFO - ##### 16:51:33 INFO - ##### Running run-tests step. 16:51:33 INFO - ##### 16:51:33 INFO - Running pre-action listener: _resource_record_pre_action 16:51:33 INFO - Running main action method: run_tests 16:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:51:33 INFO - Python 2.7.3 16:51:33 INFO - Return code: 0 16:51:33 INFO - grabbing minidump binary from tooltool 16:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:33 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 0x2d5b840>, '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 0x2cc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:51:33 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 16:51:33 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 16:51:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:33 INFO - Return code: 0 16:51:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:51:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:51:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:51:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:51:34 INFO - Return code: 0 16:51:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:51:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:51:34 INFO - Using env: {'DISPLAY': ':0', 16:51:34 INFO - 'HOME': '/home/cltbld', 16:51:34 INFO - 'LANG': 'en_US.UTF-8', 16:51:34 INFO - 'LANGUAGE': 'en_US:en', 16:51:34 INFO - 'LOGNAME': 'cltbld', 16:51:34 INFO - 'MAIL': '/var/mail/cltbld', 16:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:34 INFO - 'MOZ_NO_REMOTE': '1', 16:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:34 INFO - 'NO_EM_RESTART': '1', 16:51:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:51:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:51:34 INFO - 'SHELL': '/bin/bash', 16:51:34 INFO - 'SHLVL': '1', 16:51:34 INFO - 'TERM': 'linux', 16:51:34 INFO - 'TMOUT': '86400', 16:51:34 INFO - 'USER': 'cltbld', 16:51:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1452645923.458832-566684024', 16:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:34 INFO - '_': '/tools/buildbot/bin/python'} 16:51:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:51:34 INFO - mozversion application_buildid: 20160112143012 16:51:34 INFO - mozversion application_changeset: dd328684ee1e46c94e0ce0988c641b18ef329f39 16:51:34 INFO - mozversion application_display_name: Nightly 16:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:34 INFO - mozversion application_name: Firefox 16:51:34 INFO - mozversion application_remotingname: firefox 16:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:51:34 INFO - mozversion application_vendor: Mozilla 16:51:34 INFO - mozversion application_version: 46.0a1 16:51:34 INFO - mozversion platform_buildid: 20160112143012 16:51:34 INFO - mozversion platform_changeset: dd328684ee1e46c94e0ce0988c641b18ef329f39 16:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:51:34 INFO - mozversion platform_version: 46.0a1 16:51:34 INFO - using testdate: 1452646294 16:51:34 INFO - actual date: 1452646294 16:51:34 INFO - starting webserver on 'localhost:44976' 16:51:34 INFO - SUITE-START | Running 3 tests 16:51:34 INFO - TEST-START | dromaeo_css 16:51:34 INFO - operating with platform_type : linux_ 16:51:34 INFO - Initialising browser for dromaeo_css test... 16:51:34 INFO - TEST-INFO | started process 3314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsb1nXP/profile http://localhost:44976/getInfo.html) 16:51:39 INFO - PROCESS | 3314 | 16:51:39 INFO - PROCESS | 3314 | (process:3400): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:40 INFO - PROCESS | 3314 | __metrics Screen width/height:1600/1200 16:51:40 INFO - PROCESS | 3314 | colorDepth:24 16:51:40 INFO - PROCESS | 3314 | Browser inner width/height: 1024/697 16:51:40 INFO - PROCESS | 3314 | __metrics 16:51:40 INFO - PROCESS | 3314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:51:41 INFO - TEST-INFO | 3314: exit 0 16:51:41 INFO - Browser initialized. 16:51:41 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:41 INFO - TEST-INFO | started process 3449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsb1nXP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:43 INFO - PROCESS | 3449 | 16:51:43 INFO - PROCESS | 3449 | (process:3511): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:51:53 INFO - PROCESS | 3449 | RSS: Main: 149958656 16:51:53 INFO - PROCESS | 3449 | 16:52:43 INFO - PROCESS | 3449 | 1452646363288 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] 16:54:51 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44976/tests/dromaeo/cssquery-ext.html) 16:54:52 INFO - PROCESS | 3449 | RSS: Main: 155348992 16:54:52 INFO - PROCESS | 3449 | 16:57:54 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-ext.html (next: http://localhost:44976/tests/dromaeo/cssquery-jquery.html) 16:57:55 INFO - PROCESS | 3449 | RSS: Main: 153083904 16:57:55 INFO - PROCESS | 3449 | 17:00:57 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44976/tests/dromaeo/cssquery-mootools.html) 17:00:57 INFO - PROCESS | 3449 | RSS: Main: 152084480 17:00:57 INFO - PROCESS | 3449 | 17:03:59 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44976/tests/dromaeo/cssquery-prototype.html) 17:04:00 INFO - PROCESS | 3449 | RSS: Main: 151207936 17:04:00 INFO - PROCESS | 3449 | 17:07:02 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44976/tests/dromaeo/cssquery-yui.html) 17:07:03 INFO - PROCESS | 3449 | RSS: Main: 150900736 17:07:03 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:44976/tests/dromaeo/cssquery-yui.html (next: http://localhost:44976/tests/dromaeo/cssquery-dojo.html) 17:10:05 INFO - PROCESS | 3449 | RSS: Main: 153686016 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | __start_tp_report 17:10:05 INFO - PROCESS | 3449 | _x_x_mozilla_page_load 17:10:05 INFO - PROCESS | 3449 | _x_x_mozilla_page_load_details 17:10:05 INFO - PROCESS | 3449 | |i|pagename|runs| 17:10:05 INFO - PROCESS | 3449 | |0;dojo.html;3147.638021627512;3148.7166155046048;3158.289384888399;3176.523521471779;3225.9354812903744;5164.018836421082;5183.611229157814;5190.480951904808;5202.245674377213;5233.842984710455;5234.214867769827;5247.449017853128;5264.473552644743;5342.866428339294;5363.034653762321;4755.785989630475;4781.880452988686;4839.467658557556;4878.878028049292;4929.950700492985;4756.215224487955;4811.591014763731;4846.927296090562;4847.466778654345;4907.460179380265;4675.13510000651;4757.405324334458;4781.42622885256;4787.784549695272;4846.975765121187;4783.832565860178;4786.904261914777;4788.449328327252;4794.352762377104;4824.903501929942;4772.045590881838;4777.092352453023;4777.546133117348;4789.784459699287;4805.951940480585;4949.876253093666;5034.295198672189;5075.213341932006;5086.211637196204;5170.922436163461;5676.801311954103;5684.914726279109;5706.743196556165;5707.914381284284;5718.370979192286;5547.25112109864;5782.884342313172;5784.219130417382;5785.27684039495;5797.594168408213;5256.579473642138;5269.051570717269;5296.3379577552805;5314.5216930476445;5348.786048558053;5724.656520608777;5756.395578464285;5768.596198266081;5774.740136693859;5792.768289268466;5414.242006119146;5511.532227901758;5525.364583072917;5558;5589.972050139804;5719.942800571941;5746.942530574641;5758.0787074068785;5782.10377391505;5805.216295800097;5729.398413166641;5738.885222295531;5745.396733343023;5754.510866576388;5766.279215098113;5479.726013699299;5482.396936337;5539.833804985857;5648;5761;4369.169857727085;4377.387165796791;4385.101054283928;4412.448443944507;4420.336949457607;3902.6682731967535;3916.962005068602;3936;3943.8028098594955;3965.167314863911;5203.219517072469;5270.183121616155;5282.049231138355;5302.681839089667;5384.892302154013;5683.460071293221;5715.114157305541;5738.856528586819;5739.13912913058;5750.734838335559;5323.86690332737;5355.3841308249275;5357.196420536873;5360.061989151883;5389.7035663038905;4735.289706543977;4774.856754297377;4790.880227994328;4807.567318941312;4859.1010663027455;5948.881022379528;5963.344032156459;5965.492933100648;5969.074793407029;6001.729922153513;5756.971215143897;5758;5758.193852860519;5761.423857614205;5776.046952252831;5848.912266316093;5868.559858010752;5885.411458854252;5951.256092988377;5990.610610310316;5491.890162196813;5550.222968784454;5558.3607885092115;5636.323641162922;5636.774529018793;5673.177389278614;5674.148877668383;5675.829725108253;5676.063449530781;5677.034904066401;5447.237386765777;5476.561875050066;5497.36780270274;5517.944820551743;5572.331320241597;5512.173174023928;5512.4211957745465;5512.531434827924;5515.365732940763;5518.144687573433;5314.415414304346;5429.701366424884;5436.293281873489;5439.891202176013;5481.561475081904;5441.945580544302;5491.505764481216;5523.613347065667;5554.833354999357;5600.047991841316;5326.840194794162;5329.147336426153;5348.304720386325;5352;5353.625246232727 17:10:05 INFO - PROCESS | 3449 | |1;ext.html;536.6324068013411;551.9862003449913;554.9472800083992;569.6895192120294;600.8197540737777;34789;35539.822300888525;35938.64061359389;36027.2794544109;36073.27853442929;36178.09554761132;36228.81885590575;36336.36486358113;36367;36809;8270.255676989054;8547.10255423181;8548.829023419528;8619.224269815715;8638.524881131567;8264.83470330593;8372.916270837304;8434.957825210897;8435.114312997139;8480.067192608809;8281.337493000545;8343.499390036617;8455.365847561457;8483.448575842582;8486.024107227686;8420.24217820396;8450.535220562928;8481.151884811532;8492.872606910902;8494.06565277819;8338.082810890797;8483.74548763538;8483.95758021206;8487.575621218975;8494.06565277819;36831.63168368309;37167.814160929025;37251.4412283816;37266.44100338497;37399.25201495982;3237.6924192201704;3244.383567122263;3315.5689760331243;3689.6679298862964;3895.590962948906;28118.718812811814;28233.435331293258;29239.707602924125;29278.85360573205;29339.119826405244;3952.8023598819946;3987.461692671481;3989.900252493682;4040.676745860324;4057.310257256244;252943;253836;254486;254552;254959.72520137465;49904.75047624738;50441.49558504442;54282;54664.453355465936;61357;57160;57475.71262143746;57584.13623795647;57679.13481297784;57736.422635773946;12584.244945303128;12667.30329831868;12691.809622855664;12796.93601532005;12846.871531284754;9370.344075914756;9411.811763764686;9422.434653920787;9442.95278523603;9447.952760236154;18799;18880.622387552172;19011.429657110308;19030.904845475685;19056.904715476612;7701.961490192513;7817;7855.803604909923;7915.248051435105;7920;943.8442656961524;954.1889394015031;957.2676902169845;959.5921733263335;1088.8475613414128;28005.29986750307;28111.43777124487;28245.858770706014;28372.290692732848;28844.278893027844;1005.4319309590059;1049.7900419916048;1074.5164675895878;1088.7332603512032;1149.4138089436692;14576.854231457763;14712.55862324132;14780.48268310604;14978.700425991638;14985.175815330043;311894;315047;315214;316759;316793;50985.23522147171;51130.74434627803;51152.48847511552;51237.231441528405;51542.22686659703;1307.5554311534124;1319.221659221064;1319.9802002969964;1342.060557609677;1344.4151793969654;26885.86557067202;27683;27779.583306250828;27963.300917477227;28022.2994425141;44921;45168.096638066396;45335.31997020113;45454.77272613616;45534.316985244586;281555;281859.26985111664;281946;282377;283667;30310.393792124476;30545.694543054284;30581.08256752301;30661.54007689842;31598.210044748146;36090.27819443649;36444.27111457809;36669.44995825118;36882;37388;31012.379752405275;31398.529022065144;31749;32433;32593;32127.196820079684;32512.187195320304;32523.51214731828;32744.50883236801;33001.50497742488;33745.32509349848;34289;34426.655733443346;34622.30755384828;35154.64845351514;27211.86394068017;29036;30645.23386915345;30955;31465.213369665027;24702;24802.875985620678;24810.751892480843;24942.62586061174;25138.24585262445 17:10:05 INFO - PROCESS | 3449 | |2;jquery.html;360.9981950090249;364.2260197081201;366.5747732630149;367.51121009057954;367.9337719210542;16282.592935176626;16876.91561542192;16983.660326793455;17110.032346280183;17754.11229438528;15403.614909627266;15629;16046.518604441886;16094.517164485054;16270.26783794729;4866.537678920497;5082.771275292621;5108.8211912583065;5118.155504341779;5121.5390614844655;4989.401271847365;5052.166392545226;5078.5937125029905;5181.6113791465605;5363.570914326864;3680.2271522980204;3834.118152824852;5306.734663266821;5363.785448582052;5364.1149210380245;5408.0535906216255;5490.3411590608985;5491.203775452557;5507.091329930557;5545.944540554603;5216.113260745682;5292.629515933886;5318.175682769177;5320.17537281722;5334.413214546396;12793.808092878615;12967.610971670865;13054.934725326408;13084.803727944089;19423.611527769364;2070.637638413272;2091.8221951134174;2112.4718820294925;2146.2809958663865;2190.375742913262;8872.290216782641;10522.684319470429;12385.566505172366;12912.548060817826;13095;1802.7025540785755;1848.473185142228;1889.896055716935;1907.2943011085988;1909.9427017189507;53595.464045359826;53598.464015359736;54105.45894541083;56467.152992705145;57588.71205643987;9465.337426380225;9706.75733106678;9811.852822207673;9953.701388958343;10012.349197302152;12495.437705303284;12538.874611253954;12579.371031448574;12596.81104783429;12621.368931553385;6565.507586930999;6599.7360105595235;6617.33826617344;6640.203175618956;6642.136522252076;6137.508999280047;6269.686515674198;6371.139896114058;6455.838604034937;6499.54503184782;4443.311286750559;4476.261416866246;4495;4515.096980603892;4527.886802829889;1835.2292037344348;1888.2163901980525;1904.714292856055;1923.9326623568109;1935.7386752788193;419.5720365227512;434.3484772840739;442.08267844223366;445.944256967879;474.6748477293065;9969.651062212788;10370.948145259375;10822.24244302907;10949.781004379867;11090.22368434218;445.1697584005806;445.53886727237153;453.5713750505806;462.6992454904339;475.74785363757263;5780.942190578125;9175.44947303164;9916.206703463706;10066.547005384775;10236.925122861992;526632;529388;530892;549027;553596;70447.64776176086;71081.28918710747;72077;72523.2747672527;72636.63681681664;1098.5715570927346;1129.870064942542;1137.624583887315;1147.6098126636984;1160.4719852466937;15116.319765610793;15218.771718424012;15246.542603721906;15283.235838207822;15592.220388980279;33595.66404336023;33706;33834.83082584571;33882.66117338795;34788.30423391569;43862.56137438712;44337;45097;45194.77402612966;45667.31499027584;7296.7081316746735;7373.29953654402;7420.628968551443;7523.586202758901;7545.50954187976;9852.655157069468;11301.491432885376;11566.42167891619;11584.829744430572;11774.234674746114;9257.398269112486;9429.858552121861;9549.331546791658;9838.26213034011;9840.55717492729;8955;9281.907180928105;9666.03339666056;9952.054554817281;10106.090451859369;9211.170994610517;9474.57364418589;9530.094641009093;9794.853077203705;9843.852342215016;7355.5586664800285;7386.667599958122;7496.0255166827965;7562.546247225184;7625;8557.529335886336;9066.909330906607;9364.438133712;9386.859197112186;9478.526073696425 17:10:05 INFO - PROCESS | 3449 | |3;mootools.html;1495.4242616592612;1511.9546413607593;1653.2147230065714;1792.3189188108518;1806.6179372779818;7628.694852205912;7640.656170472328;7840;7845.882311765328;7877.80305492363;7877.606119694006;7903.802404939879;7967.92032079679;7973.720919767809;7977.04275486941;2366.25462979161;2385.654080158376;2390.486045500217;2394.760523947609;2398.9040438382444;2363.468219650582;2364.042562762084;2372.620380739082;2379.1910750344878;2426.684531010966;2216.8448208625405;2292.7363353214346;2295.9540809183804;2351.6354964980455;2381.9642705359433;2294.1511640692884;2295.5638428698494;2313.7801908818637;2317.73346065203;2327.755585663498;2326.6975293211945;2339.1345202275265;2346.5189636124555;2349.2482405630203;2355.9646605300936;7617.46677732559;7702.614869256515;7704.9598304228775;7712.113106992711;7713.6914523419;4661.230896902007;4689.944762428427;4732.787024583902;4771.6898401603785;4783.784729687172;2969.62879640045;2973.2566858285427;2999.9850000749857;3033.2265272355407;3070.078976307121;963.1668606655263;974.4348277998744;979.3732011512637;988.1353815411514;1024.7950409917971;10881.727956801064;10991.340519568852;10996.890031099747;11050.834237486444;11092.778144437147;4309.513217939806;4338.609525142752;4359.542248063971;4399.406080179135;4414.09511050234;8697.608607612672;8882.289416846637;8920.955395222982;8921.107889211027;8924.464532128093;4718.150732868048;4725.9527404726205;4727.101850648366;4729.101470720552;4738.905221895543;4354.542773008852;4410.20616289071;4421.159979603865;4422.402975598317;4449.51055383914;3469.6877281044826;3496.8950931472095;3498.8425520851624;3504.4392897136336;3523.031166429201;1095.4303762043692;1116.0959622705634;1116.7319843237726;1123.1800785426685;1126.099120703434;1010.6715317521835;1036.0675392146977;1075.854759607443;1147.4492243722893;1324.9797655804975;6993.2657071006815;7005.1944026436595;7041.788746337618;7083.114610673666;7180.1742799578715;1105.8285965675334;1116.7096554895786;1126.5606413498742;1127.115214556569;1137.7383201863618;5591.105423132361;5681.091025435993;5684.976704193202;5687.687177205211;5695.202671625976;9342.95328523353;9391.201747851372;9739.610415583438;9777.46223957675;9793.706188814347;9493.288003399635;9571.856422153673;9595.568199431042;9631.133198012212;9655.903440965641;7232.312930271616;7287.744928927462;7458.254174582498;7466.738664146729;7500.774976750816;7079;7115.039469671528;7135;7160.964195178991;7167.498275120692;8291.253787159185;8377.45546539473;8600.569971501274;8625.137486251324;8657.696980605648;8606.010308814566;8814.382993190415;8838;8846.424982376382;8877;6662.533622646562;6773.966130169515;6809.8638027238185;6812.489063320171;6815.250322464624;7578.545287282781;7591.3547348475995;7631.198724133886;7675.769726908202;7690.884636730565;6311.684415779101;7007.8248043797275;7210.89183662235;7266.164391094881;7331.8533629328185;6324.588901721373;6638.867222655616;6888;7012.053372794811;7135.607541585055;6971.058907047483;6986.54587451814;7002;7113.430925526049;7119.964400177966;6440.806775796734;6498.74005039812;6498.772542960974;6526.184226971629;6580.572262803094;6634.867302653824;6661.2006559213205;6668.599884006975;6674.43267322283;6676.0987266718375 17:10:05 INFO - PROCESS | 3449 | |4;prototype.html;338.14280798176617;350.70365541117764;352.05824419677356;355.91991801844574;357.19096247000533;6159.969200154004;6235.158253635758;6270.090836828668;6350.142730731362;6360.840978975522;6123.295820980588;6132.969335153318;6246.344133865936;6274.905876411857;6296.937030629692;4768.690035147722;4774.092922344761;4774.140654682155;4775.068861571995;4777.808887644499;4776.761161941889;4786.904261914759;4789.976050119762;4791.856244312658;4794.304825800257;4660.6970546914345;4745.454272758642;4748.121597504455;4749.097671442432;4750.0024994750975;4699.95300047002;4736.029114031615;4737.076270127326;4742.027884283713;4757.024809913959;4104.445899803548;4112.938305925413;4114.629683328485;4118.567550407194;4125.154343359604;5892.675902825343;5918.437748413894;5949.167116603679;5956.195913551658;5965.164876917235;5408.783648654088;5514.255575497296;5519.641223320512;5522.3649280332875;5523.7238138093335;6599;6599.835004124887;6600.80197594073;6605.9339406605795;6610.603363798139;4523.683342166049;4528.479224889114;4536.77316134192;4539.568740969636;4553.840615578472;6597.373249541286;6839.965800171017;6930.549514281555;6960.095187625627;6961.025456436103;4559.065391594715;4560.293154561048;4604.723716576949;4644.814207431732;4645.233536466513;4586.3579098926175;4598.471175814757;4604.240300350405;4605.792739326738;4608.792604332813;5352.9732351338;5395.21769343443;5416.864578385572;5417.756200970965;5417.864553386197;6420.357964203542;6553.63954982471;6562.114114594468;6568.441682456949;6609.570377925419;1598.9360425582847;1614.7900772899447;1635.1006946179791;1639.442589519569;1641.0317912431722;1087.3856271206744;1111.4831603304501;1112.6995711157942;1116.1071143085499;1119.9888001119884;6168.814935551941;6198.411150940744;6199.56603037783;6199.659018754011;6209.844753881189;6582.901256481156;6595.373439523238;6659.433948114464;6664.733410663616;6667.199936007613;6087.36082711309;6111.908321375183;6153.323134455206;6185.938140618626;6191;3621.6921561667555;3646.5077214575695;3655.908602284964;3658.63413658632;3665.486831843544;6936.687849046805;6984.825379365557;6991.545549539263;7017.157941047107;7024.964875175591;6738.393544581011;6836.38472537474;6864.553804002724;6867.862642747117;6884.831278147368;6810.557313774688;6956.513044086865;6962.930370696329;6971;6980;6555.573887697285;6591.868162636816;6641.535092543476;6670.332966703291;6685.130932978682;6486.805395838132;6494.6752662367635;6551.6069035858;6595.736170553124;6620.271770105188;6969.477289203432;6981.057557229709;6989;6990.370866622028;6999.335063168991;4603.263477843529;4605.102005108972;4606.6314694825005;4613.146567884952;4617.6536759742485;6653.700583473658;6663.13379260693;6675.632840193836;6681.69932353055;6745.156855393076;6598.868022639424;6649.368310010541;6651.50113741481;6653.933460665525;6656.001599760075;6511.479081673549;6563.7702680407865;6565.573237739532;6641.601503909781;6658.3674550917585;6231.127642130196;6501.772437964649;6502.837429064311;6513.674316284072;6538.738450461929;6529.379708927644;6665.933340666531;6673.532852700265;6677.666116694243;6687.799366019027;6342.556021078481;6373.107764913008;6375.107484952017;6432.2602900667025;6462.353764623688 17:10:05 INFO - PROCESS | 3449 | |5;yui.html;846.678262260341;857.618359829876;857.9914200857993;863.8920134983128;864.9999999999998;13398.1961082335;13494.325283735798;13546.322683865805;13549.458021679146;13577.796333055;12684.492620295177;12743.745125097492;12811.551595694129;12836.807447888266;12860.67848303793;768.4313607930119;771.8687823070092;780.9258120478573;786.3905473258213;790.0637744273026;797.6171437709903;798.0543056478064;801.3789313282224;802.4623502253474;805.6012273924416;830.6760363458257;832.8042909916165;849.5030407211789;850.6129710981488;852.667459690718;840.0381563110204;841.6885752271637;845.7082306604211;846.6317152038882;847.3009766942297;623.1431781300712;626.1203009771233;629.6033498895666;629.8834715577588;631.4348657951108;12691;12709.364531773374;12820.807687884597;12869.613911582574;12888.484460621565;12463.875361246362;12629.494820207181;12694.746105077938;12981.286029268387;13039.217646941119;9438.952805235998;9757.804843903154;9814.116729494379;9947.452890091043;10443.74519957383;3497.1082373994723;3506.68439840413;3548.822558872046;3563.5367402237803;3566.6076731559506;48384;48732.756336218095;48796.756016220046;48972.26541601843;49033.50966490325;9688.757781055388;9805.852912206323;9915.355501892354;9939.155171810333;10226;17675.646487070186;17701.557461063578;17706.29174833018;17734.91132544329;17743.911280443772;7056.294370562902;7317.15852676949;7328.193898671142;7363.116426028911;7680.308772210527;4165.396017577495;4211.873643790691;4237.470316210473;4241.63946064588;4242.957570424256;3028.046165457874;3069.3707789903015;3069.754419646423;3070.3552254026904;3072.7080927311868;564.7119968815933;569.6041251330286;577.3302968556538;577.5408550202599;580.4804699793661;591.3229352391488;635.4725577770532;637.9664942792613;651.6709061923698;666.7666316789085;8331.66673333072;8682.43696268672;8686.174813392843;8752.737417877473;8876.689315873913;519.9246109314129;632.7785275153659;664.62448716476;678.2776343194482;685.5201359048685;4053;4065.6340929316502;4067.593240675909;4132.8140233689555;4191.538930717618;54507;54538.72730636401;54682;54795;55180.724096380065;46708.53291467042;48605.270920936215;49613.75193124011;51997.48002520002;52126.73936630293;43869.341959870624;44701.32948005782;44830.068692443805;45052.774736126106;45248.999999999345;8442.788930276793;8518.23335899772;9015.639374424949;9029.77425564366;9035.186833185046;31930.36139277155;32778.92897266259;32873.67126328706;33389.33221335511;33755.81854635076;36976.445353319185;41133.794331028155;41554.79222603868;41669;42322.576774231864;10811.295561888577;10839.349639021684;10915.345079295268;11056.613018544313;11249.606263780728;12226.755464890475;12370.81443778362;12375.133740638068;12462.376881155724;12843.807342889677;11105.444727763741;11296.378699171624;11420.143489238175;11679.591214307458;11787.292762434281;11292.717682057686;11593.768124637292;11743.530258789553;11830.585929492427;12088.75822483563;11257.268277561932;11346.546138154381;11750;11766.411679415824;11831.290122592673;9332.30007749408;9582.616695332108;9618.51907404641;9637.614495420385;9931.602735890772;8994;9150.542472876197;9360;9583.904160958302;9970.501474926079 17:10:05 INFO - PROCESS | 3449 | __end_tp_report 17:10:05 INFO - PROCESS | 3449 | __start_cc_report 17:10:05 INFO - PROCESS | 3449 | _x_x_mozilla_cycle_collect,306 17:10:05 INFO - PROCESS | 3449 | __end_cc_report 17:10:05 INFO - PROCESS | 3449 | __startTimestamp1452647405718__endTimestamp 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | ------- Summary: start ------- 17:10:05 INFO - PROCESS | 3449 | Number of tests: 6 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#0] dojo.html Cycles:165 Average:5258.60 Median:5429.70 stddev:591.73 (10.9%) stddev-sans-first:569.90 17:10:05 INFO - PROCESS | 3449 | Values: 3147.6 3148.7 3158.3 3176.5 3225.9 5164.0 5183.6 5190.5 5202.2 5233.8 5234.2 5247.4 5264.5 5342.9 5363.0 4755.8 4781.9 4839.5 4878.9 4930.0 4756.2 4811.6 4846.9 4847.5 4907.5 4675.1 4757.4 4781.4 4787.8 4847.0 4783.8 4786.9 4788.4 4794.4 4824.9 4772.0 4777.1 4777.5 4789.8 4806.0 4949.9 5034.3 5075.2 5086.2 5170.9 5676.8 5684.9 5706.7 5707.9 5718.4 5547.3 5782.9 5784.2 5785.3 5797.6 5256.6 5269.1 5296.3 5314.5 5348.8 5724.7 5756.4 5768.6 5774.7 5792.8 5414.2 5511.5 5525.4 5558.0 5590.0 5719.9 5746.9 5758.1 5782.1 5805.2 5729.4 5738.9 5745.4 5754.5 5766.3 5479.7 5482.4 5539.8 5648.0 5761.0 4369.2 4377.4 4385.1 4412.4 4420.3 3902.7 3917.0 3936.0 3943.8 3965.2 5203.2 5270.2 5282.0 5302.7 5384.9 5683.5 5715.1 5738.9 5739.1 5750.7 5323.9 5355.4 5357.2 5360.1 5389.7 4735.3 4774.9 4790.9 4807.6 4859.1 5948.9 5963.3 5965.5 5969.1 6001.7 5757.0 5758.0 5758.2 5761.4 5776.0 5848.9 5868.6 5885.4 5951.3 5990.6 5491.9 5550.2 5558.4 5636.3 5636.8 5673.2 5674.1 5675.8 5676.1 5677.0 5447.2 5476.6 5497.4 5517.9 5572.3 5512.2 5512.4 5512.5 5515.4 5518.1 5314.4 5429.7 5436.3 5439.9 5481.6 5441.9 5491.5 5523.6 5554.8 5600.0 5326.8 5329.1 5348.3 5352.0 5353.6 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#1] ext.html Cycles:180 Average:44229.43 Median:35739.23 stddev:74523.98 (208.5%) stddev-sans-first:74660.83 17:10:05 INFO - PROCESS | 3449 | Values: 536.6 552.0 554.9 569.7 600.8 34789.0 35539.8 35938.6 36027.3 36073.3 36178.1 36228.8 36336.4 36367.0 36809.0 8270.3 8547.1 8548.8 8619.2 8638.5 8264.8 8372.9 8435.0 8435.1 8480.1 8281.3 8343.5 8455.4 8483.4 8486.0 8420.2 8450.5 8481.2 8492.9 8494.1 8338.1 8483.7 8484.0 8487.6 8494.1 36831.6 37167.8 37251.4 37266.4 37399.3 3237.7 3244.4 3315.6 3689.7 3895.6 28118.7 28233.4 29239.7 29278.9 29339.1 3952.8 3987.5 3989.9 4040.7 4057.3 252943.0 253836.0 254486.0 254552.0 254959.7 49904.8 50441.5 54282.0 54664.5 61357.0 57160.0 57475.7 57584.1 57679.1 57736.4 12584.2 12667.3 12691.8 12796.9 12846.9 9370.3 9411.8 9422.4 9443.0 9448.0 18799.0 18880.6 19011.4 19030.9 19056.9 7702.0 7817.0 7855.8 7915.2 7920.0 943.8 954.2 957.3 959.6 1088.8 28005.3 28111.4 28245.9 28372.3 28844.3 1005.4 1049.8 1074.5 1088.7 1149.4 14576.9 14712.6 14780.5 14978.7 14985.2 311894.0 315047.0 315214.0 316759.0 316793.0 50985.2 51130.7 51152.5 51237.2 51542.2 1307.6 1319.2 1320.0 1342.1 1344.4 26885.9 27683.0 27779.6 27963.3 28022.3 44921.0 45168.1 45335.3 45454.8 45534.3 281555.0 281859.3 281946.0 282377.0 283667.0 30310.4 30545.7 30581.1 30661.5 31598.2 36090.3 36444.3 36669.4 36882.0 37388.0 31012.4 31398.5 31749.0 32433.0 32593.0 32127.2 32512.2 32523.5 32744.5 33001.5 33745.3 34289.0 34426.7 34622.3 35154.6 27211.9 29036.0 30645.2 30955.0 31465.2 24702.0 24802.9 24810.8 24942.6 25138.2 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#2] jquery.html Cycles:180 Average:27084.48 Median:468.69 stddev:87935.60 (18762.1%) stddev-sans-first:88159.39 17:10:05 INFO - PROCESS | 3449 | Values: 361.0 364.2 366.6 367.5 367.9 16282.6 16876.9 16983.7 17110.0 17754.1 15403.6 15629.0 16046.5 16094.5 16270.3 4866.5 5082.8 5108.8 5118.2 5121.5 4989.4 5052.2 5078.6 5181.6 5363.6 3680.2 3834.1 5306.7 5363.8 5364.1 5408.1 5490.3 5491.2 5507.1 5545.9 5216.1 5292.6 5318.2 5320.2 5334.4 12793.8 12967.6 13054.9 13084.8 19423.6 2070.6 2091.8 2112.5 2146.3 2190.4 8872.3 10522.7 12385.6 12912.5 13095.0 1802.7 1848.5 1889.9 1907.3 1909.9 53595.5 53598.5 54105.5 56467.2 57588.7 9465.3 9706.8 9811.9 9953.7 10012.3 12495.4 12538.9 12579.4 12596.8 12621.4 6565.5 6599.7 6617.3 6640.2 6642.1 6137.5 6269.7 6371.1 6455.8 6499.5 4443.3 4476.3 4495.0 4515.1 4527.9 1835.2 1888.2 1904.7 1923.9 1935.7 419.6 434.3 442.1 445.9 474.7 9969.7 10370.9 10822.2 10949.8 11090.2 445.2 445.5 453.6 462.7 475.7 5780.9 9175.4 9916.2 10066.5 10236.9 526632.0 529388.0 530892.0 549027.0 553596.0 70447.6 71081.3 72077.0 72523.3 72636.6 1098.6 1129.9 1137.6 1147.6 1160.5 15116.3 15218.8 15246.5 15283.2 15592.2 33595.7 33706.0 33834.8 33882.7 34788.3 43862.6 44337.0 45097.0 45194.8 45667.3 7296.7 7373.3 7420.6 7523.6 7545.5 9852.7 11301.5 11566.4 11584.8 11774.2 9257.4 9429.9 9549.3 9838.3 9840.6 8955.0 9281.9 9666.0 9952.1 10106.1 9211.2 9474.6 9530.1 9794.9 9843.9 7355.6 7386.7 7496.0 7562.5 7625.0 8557.5 9066.9 9364.4 9386.9 9478.5 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#3] mootools.html Cycles:180 Average:5498.11 Median:6512.48 stddev:2853.33 (43.8%) stddev-sans-first:2845.47 17:10:05 INFO - PROCESS | 3449 | Values: 1495.4 1512.0 1653.2 1792.3 1806.6 7628.7 7640.7 7840.0 7845.9 7877.8 7877.6 7903.8 7967.9 7973.7 7977.0 2366.3 2385.7 2390.5 2394.8 2398.9 2363.5 2364.0 2372.6 2379.2 2426.7 2216.8 2292.7 2296.0 2351.6 2382.0 2294.2 2295.6 2313.8 2317.7 2327.8 2326.7 2339.1 2346.5 2349.2 2356.0 7617.5 7702.6 7705.0 7712.1 7713.7 4661.2 4689.9 4732.8 4771.7 4783.8 2969.6 2973.3 3000.0 3033.2 3070.1 963.2 974.4 979.4 988.1 1024.8 10881.7 10991.3 10996.9 11050.8 11092.8 4309.5 4338.6 4359.5 4399.4 4414.1 8697.6 8882.3 8921.0 8921.1 8924.5 4718.2 4726.0 4727.1 4729.1 4738.9 4354.5 4410.2 4421.2 4422.4 4449.5 3469.7 3496.9 3498.8 3504.4 3523.0 1095.4 1116.1 1116.7 1123.2 1126.1 1010.7 1036.1 1075.9 1147.4 1325.0 6993.3 7005.2 7041.8 7083.1 7180.2 1105.8 1116.7 1126.6 1127.1 1137.7 5591.1 5681.1 5685.0 5687.7 5695.2 9343.0 9391.2 9739.6 9777.5 9793.7 9493.3 9571.9 9595.6 9631.1 9655.9 7232.3 7287.7 7458.3 7466.7 7500.8 7079.0 7115.0 7135.0 7161.0 7167.5 8291.3 8377.5 8600.6 8625.1 8657.7 8606.0 8814.4 8838.0 8846.4 8877.0 6662.5 6774.0 6809.9 6812.5 6815.3 7578.5 7591.4 7631.2 7675.8 7690.9 6311.7 7007.8 7210.9 7266.2 7331.9 6324.6 6638.9 6888.0 7012.1 7135.6 6971.1 6986.5 7002.0 7113.4 7120.0 6440.8 6498.7 6498.8 6526.2 6580.6 6634.9 6661.2 6668.6 6674.4 6676.1 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#4] prototype.html Cycles:180 Average:5468.78 Median:6199.61 stddev:1645.79 (26.5%) stddev-sans-first:1604.72 17:10:05 INFO - PROCESS | 3449 | Values: 338.1 350.7 352.1 355.9 357.2 6160.0 6235.2 6270.1 6350.1 6360.8 6123.3 6133.0 6246.3 6274.9 6296.9 4768.7 4774.1 4774.1 4775.1 4777.8 4776.8 4786.9 4790.0 4791.9 4794.3 4660.7 4745.5 4748.1 4749.1 4750.0 4700.0 4736.0 4737.1 4742.0 4757.0 4104.4 4112.9 4114.6 4118.6 4125.2 5892.7 5918.4 5949.2 5956.2 5965.2 5408.8 5514.3 5519.6 5522.4 5523.7 6599.0 6599.8 6600.8 6605.9 6610.6 4523.7 4528.5 4536.8 4539.6 4553.8 6597.4 6840.0 6930.5 6960.1 6961.0 4559.1 4560.3 4604.7 4644.8 4645.2 4586.4 4598.5 4604.2 4605.8 4608.8 5353.0 5395.2 5416.9 5417.8 5417.9 6420.4 6553.6 6562.1 6568.4 6609.6 1598.9 1614.8 1635.1 1639.4 1641.0 1087.4 1111.5 1112.7 1116.1 1120.0 6168.8 6198.4 6199.6 6199.7 6209.8 6582.9 6595.4 6659.4 6664.7 6667.2 6087.4 6111.9 6153.3 6185.9 6191.0 3621.7 3646.5 3655.9 3658.6 3665.5 6936.7 6984.8 6991.5 7017.2 7025.0 6738.4 6836.4 6864.6 6867.9 6884.8 6810.6 6956.5 6962.9 6971.0 6980.0 6555.6 6591.9 6641.5 6670.3 6685.1 6486.8 6494.7 6551.6 6595.7 6620.3 6969.5 6981.1 6989.0 6990.4 6999.3 4603.3 4605.1 4606.6 4613.1 4617.7 6653.7 6663.1 6675.6 6681.7 6745.2 6598.9 6649.4 6651.5 6653.9 6656.0 6511.5 6563.8 6565.6 6641.6 6658.4 6231.1 6501.8 6502.8 6513.7 6538.7 6529.4 6665.9 6673.5 6677.7 6687.8 6342.6 6373.1 6375.1 6432.3 6462.4 17:10:05 INFO - PROCESS | 3449 | 17:10:05 INFO - PROCESS | 3449 | [#5] yui.html Cycles:180 Average:13463.44 Median:48764.76 stddev:15315.61 (31.4%) stddev-sans-first:15329.27 17:10:05 INFO - PROCESS | 3449 | Values: 846.7 857.6 858.0 863.9 865.0 13398.2 13494.3 13546.3 13549.5 13577.8 12684.5 12743.7 12811.6 12836.8 12860.7 768.4 771.9 780.9 786.4 790.1 797.6 798.1 801.4 802.5 805.6 830.7 832.8 849.5 850.6 852.7 840.0 841.7 845.7 846.6 847.3 623.1 626.1 629.6 629.9 631.4 12691.0 12709.4 12820.8 12869.6 12888.5 12463.9 12629.5 12694.7 12981.3 13039.2 9439.0 9757.8 9814.1 9947.5 10443.7 3497.1 3506.7 3548.8 3563.5 3566.6 48384.0 48732.8 48796.8 48972.3 49033.5 9688.8 9805.9 9915.4 9939.2 10226.0 17675.6 17701.6 17706.3 17734.9 17743.9 7056.3 7317.2 7328.2 7363.1 7680.3 4165.4 4211.9 4237.5 4241.6 4243.0 3028.0 3069.4 3069.8 3070.4 3072.7 564.7 569.6 577.3 577.5 580.5 591.3 635.5 638.0 651.7 666.8 8331.7 8682.4 8686.2 8752.7 8876.7 519.9 632.8 664.6 678.3 685.5 4053.0 4065.6 4067.6 4132.8 4191.5 54507.0 54538.7 54682.0 54795.0 55180.7 46708.5 48605.3 49613.8 51997.5 52126.7 43869.3 44701.3 44830.1 45052.8 45249.0 8442.8 8518.2 9015.6 9029.8 9035.2 31930.4 32778.9 32873.7 33389.3 33755.8 36976.4 41133.8 41554.8 41669.0 42322.6 10811.3 10839.3 10915.3 11056.6 11249.6 12226.8 12370.8 12375.1 12462.4 12843.8 11105.4 11296.4 11420.1 11679.6 11787.3 11292.7 11593.8 11743.5 11830.6 12088.8 11257.3 11346.5 11750.0 11766.4 11831.3 9332.3 9582.6 9618.5 9637.6 9931.6 8994.0 9150.5 9360.0 9583.9 9970.5 17:10:05 INFO - PROCESS | 3449 | -------- Summary: end -------- 17:10:05 INFO - PROCESS | 3449 | 17:10:06 INFO - TEST-INFO | 3449: exit 0 17:10:06 INFO - TEST-OK | dromaeo_css | took 1111737ms 17:10:06 INFO - TEST-START | kraken 17:10:06 INFO - operating with platform_type : linux_ 17:10:06 INFO - Initialising browser for kraken test... 17:10:06 INFO - TEST-INFO | started process 3692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQY14G6/profile http://localhost:44976/getInfo.html) 17:10:09 INFO - PROCESS | 3692 | 17:10:09 INFO - PROCESS | 3692 | (process:3762): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:10 INFO - PROCESS | 3692 | __metrics Screen width/height:1600/1200 17:10:10 INFO - PROCESS | 3692 | colorDepth:24 17:10:10 INFO - PROCESS | 3692 | Browser inner width/height: 1024/697 17:10:10 INFO - PROCESS | 3692 | __metrics 17:10:10 INFO - PROCESS | 3692 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:11 INFO - TEST-INFO | 3692: exit 0 17:10:11 INFO - Browser initialized. 17:10:11 INFO - Running cycle 1/1 for kraken test... 17:10:11 INFO - TEST-INFO | started process 3811 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQY14G6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:13 INFO - PROCESS | 3811 | 17:10:13 INFO - PROCESS | 3811 | (process:3872): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:23 INFO - PROCESS | 3811 | RSS: Main: 149876736 17:10:23 INFO - PROCESS | 3811 | 17:10:26 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:26 INFO - PROCESS | 3811 | RSS: Main: 150843392 17:10:26 INFO - PROCESS | 3811 | 17:10:29 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-dft) 17:10:30 INFO - PROCESS | 3811 | RSS: Main: 151625728 17:10:30 INFO - PROCESS | 3811 | 17:10:32 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-fft) 17:10:33 INFO - PROCESS | 3811 | RSS: Main: 146554880 17:10:33 INFO - PROCESS | 3811 | 17:10:35 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator) 17:10:36 INFO - PROCESS | 3811 | RSS: Main: 147316736 17:10:36 INFO - PROCESS | 3811 | 17:10:38 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:39 INFO - PROCESS | 3811 | RSS: Main: 146591744 17:10:39 INFO - PROCESS | 3811 | 17:10:42 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:42 INFO - PROCESS | 3811 | RSS: Main: 147386368 17:10:42 INFO - PROCESS | 3811 | 17:10:46 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:46 INFO - PROCESS | 3811 | RSS: Main: 148365312 17:10:46 INFO - PROCESS | 3811 | 17:10:49 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial) 17:10:50 INFO - PROCESS | 3811 | RSS: Main: 148787200 17:10:50 INFO - PROCESS | 3811 | 17:10:51 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:52 INFO - PROCESS | 3811 | RSS: Main: 149172224 17:10:52 INFO - PROCESS | 3811 | 17:10:54 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:54 INFO - PROCESS | 3811 | RSS: Main: 148664320 17:10:54 INFO - PROCESS | 3811 | 17:10:56 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:57 INFO - PROCESS | 3811 | RSS: Main: 149123072 17:10:57 INFO - PROCESS | 3811 | 17:11:00 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:00 INFO - PROCESS | 3811 | RSS: Main: 149061632 17:11:00 INFO - PROCESS | 3811 | 17:11:03 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:03 INFO - PROCESS | 3811 | RSS: Main: 147165184 17:11:03 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:44976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44976/tests/kraken/driver.html?testName=ai-astar) 17:11:05 INFO - PROCESS | 3811 | RSS: Main: 148033536 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | __start_tp_report 17:11:05 INFO - PROCESS | 3811 | _x_x_mozilla_page_load 17:11:05 INFO - PROCESS | 3811 | _x_x_mozilla_page_load_details 17:11:05 INFO - PROCESS | 3811 | |i|pagename|runs| 17:11:05 INFO - PROCESS | 3811 | |0;ai-astar;112;106;112;112;113;124;112;113;113;112 17:11:05 INFO - PROCESS | 3811 | |1;audio-beat-detection;159;128;146;170;133;153;155;129;168;131 17:11:05 INFO - PROCESS | 3811 | |2;audio-dft;163;163;163;162;163;162;165;170;166;163 17:11:05 INFO - PROCESS | 3811 | |3;audio-fft;72;73;71;76;75;137;71;73;73;73 17:11:05 INFO - PROCESS | 3811 | |4;audio-oscillator;96;98;141;99;97;96;141;96;97;141 17:11:05 INFO - PROCESS | 3811 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;110;110 17:11:05 INFO - PROCESS | 3811 | |6;imaging-darkroom;149;146;145;146;147;147;146;147;146;147 17:11:05 INFO - PROCESS | 3811 | |7;imaging-desaturate;97;97;96;97;97;96;97;96;96;96 17:11:05 INFO - PROCESS | 3811 | |8;json-parse-financial;59;57;58;58;60;57;59;60;57;58 17:11:05 INFO - PROCESS | 3811 | |9;json-stringify-tinderbox;68;68;67;67;69;69;68;70;68;68 17:11:05 INFO - PROCESS | 3811 | |10;stanford-crypto-aes;92;86;85;85;87;93;91;87;86;86 17:11:05 INFO - PROCESS | 3811 | |11;stanford-crypto-ccm;116;120;124;124;120;129;120;125;131;118 17:11:05 INFO - PROCESS | 3811 | |12;stanford-crypto-pbkdf2;143;159;162;157;144;152;142;156;147;140 17:11:05 INFO - PROCESS | 3811 | |13;stanford-crypto-sha256-iterative;69;69;71;68;69;69;69;68;69;67 17:11:05 INFO - PROCESS | 3811 | __end_tp_report 17:11:05 INFO - PROCESS | 3811 | __start_cc_report 17:11:05 INFO - PROCESS | 3811 | _x_x_mozilla_cycle_collect,740 17:11:05 INFO - PROCESS | 3811 | __end_cc_report 17:11:05 INFO - PROCESS | 3811 | __startTimestamp1452647465793__endTimestamp 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | ------- Summary: start ------- 17:11:05 INFO - PROCESS | 3811 | Number of tests: 14 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.41 (3.9%) stddev-sans-first:4.66 17:11:05 INFO - PROCESS | 3811 | Values: 112.0 106.0 112.0 112.0 113.0 124.0 112.0 113.0 113.0 112.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:154.00 stddev:16.16 (10.5%) stddev-sans-first:16.57 17:11:05 INFO - PROCESS | 3811 | Values: 159.0 128.0 146.0 170.0 133.0 153.0 155.0 129.0 168.0 131.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:2.45 (1.5%) stddev-sans-first:2.57 17:11:05 INFO - PROCESS | 3811 | Values: 163.0 163.0 163.0 162.0 163.0 162.0 165.0 170.0 166.0 163.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#3] audio-fft Cycles:10 Average:79.40 Median:73.00 stddev:20.30 (27.8%) stddev-sans-first:21.35 17:11:05 INFO - PROCESS | 3811 | Values: 72.0 73.0 71.0 76.0 75.0 137.0 71.0 73.0 73.0 73.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.50 stddev:21.27 (22.0%) stddev-sans-first:21.94 17:11:05 INFO - PROCESS | 3811 | Values: 96.0 98.0 141.0 99.0 97.0 96.0 141.0 96.0 97.0 141.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:11:05 INFO - PROCESS | 3811 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:0.71 17:11:05 INFO - PROCESS | 3811 | Values: 149.0 146.0 145.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:11:05 INFO - PROCESS | 3811 | Values: 97.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 96.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:1.16 (2.0%) stddev-sans-first:1.20 17:11:05 INFO - PROCESS | 3811 | Values: 59.0 57.0 58.0 58.0 60.0 57.0 59.0 60.0 57.0 58.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 17:11:05 INFO - PROCESS | 3811 | Values: 68.0 68.0 67.0 67.0 69.0 69.0 68.0 70.0 68.0 68.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:3.01 (3.5%) stddev-sans-first:2.78 17:11:05 INFO - PROCESS | 3811 | Values: 92.0 86.0 85.0 85.0 87.0 93.0 91.0 87.0 86.0 86.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:124.00 stddev:4.79 (3.9%) stddev-sans-first:4.42 17:11:05 INFO - PROCESS | 3811 | Values: 116.0 120.0 124.0 124.0 120.0 129.0 120.0 125.0 131.0 118.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:154.00 stddev:7.97 (5.2%) stddev-sans-first:8.02 17:11:05 INFO - PROCESS | 3811 | Values: 143.0 159.0 162.0 157.0 144.0 152.0 142.0 156.0 147.0 140.0 17:11:05 INFO - PROCESS | 3811 | 17:11:05 INFO - PROCESS | 3811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 17:11:05 INFO - PROCESS | 3811 | Values: 69.0 69.0 71.0 68.0 69.0 69.0 69.0 68.0 69.0 67.0 17:11:05 INFO - PROCESS | 3811 | -------- Summary: end -------- 17:11:05 INFO - PROCESS | 3811 | 17:11:06 INFO - TEST-INFO | 3811: exit 0 17:11:06 INFO - TEST-OK | kraken | took 60210ms 17:11:06 INFO - TEST-START | v8_7 17:11:06 INFO - operating with platform_type : linux_ 17:11:06 INFO - Initialising browser for v8_7 test... 17:11:06 INFO - TEST-INFO | started process 4100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptTAfYg/profile http://localhost:44976/getInfo.html) 17:11:10 INFO - PROCESS | 4100 | 17:11:10 INFO - PROCESS | 4100 | (process:4172): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:10 INFO - PROCESS | 4100 | __metrics Screen width/height:1600/1200 17:11:10 INFO - PROCESS | 4100 | colorDepth:24 17:11:10 INFO - PROCESS | 4100 | Browser inner width/height: 1024/697 17:11:10 INFO - PROCESS | 4100 | __metrics 17:11:11 INFO - PROCESS | 4100 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:11:11 INFO - TEST-INFO | 4100: exit 0 17:11:11 INFO - Browser initialized. 17:11:11 INFO - Running cycle 1/1 for v8_7 test... 17:11:11 INFO - TEST-INFO | started process 4221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptTAfYg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:13 INFO - PROCESS | 4221 | 17:11:13 INFO - PROCESS | 4221 | (process:4276): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:23 INFO - PROCESS | 4221 | RSS: Main: 150847488 17:11:23 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | Cycle 1(1): loaded http://localhost:44976/tests/v8_7/run.html (next: http://localhost:44976/tests/v8_7/run.html) 17:11:46 INFO - PROCESS | 4221 | RSS: Main: 145592320 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | __start_tp_report 17:11:46 INFO - PROCESS | 4221 | _x_x_mozilla_page_load 17:11:46 INFO - PROCESS | 4221 | _x_x_mozilla_page_load_details 17:11:46 INFO - PROCESS | 4221 | |i|pagename|runs| 17:11:46 INFO - PROCESS | 4221 | |0;Richards;167.19612104999163 17:11:46 INFO - PROCESS | 4221 | |1;DeltaBlue;189.53752843062927 17:11:46 INFO - PROCESS | 4221 | |2;Encrypt;279.72027972027973 17:11:46 INFO - PROCESS | 4221 | |3;Decrypt;5251.308900523561 17:11:46 INFO - PROCESS | 4221 | |4;RayTrace;1070.6638115631692 17:11:46 INFO - PROCESS | 4221 | |5;Earley;725.6894049346879 17:11:46 INFO - PROCESS | 4221 | |6;Boyer;12506.172839506173 17:11:46 INFO - PROCESS | 4221 | |7;RegExp;41469.38775510204 17:11:46 INFO - PROCESS | 4221 | |8;Splay;579.219288174512 17:11:46 INFO - PROCESS | 4221 | |9;NavierStokes;4845.410628019324 17:11:46 INFO - PROCESS | 4221 | __end_tp_report 17:11:46 INFO - PROCESS | 4221 | __startTimestamp1452647506501__endTimestamp 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | ------- Summary: start ------- 17:11:46 INFO - PROCESS | 4221 | Number of tests: 10 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#0] Richards Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 167.2 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#1] DeltaBlue Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 189.5 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 279.7 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 5251.3 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 1070.7 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#5] Earley Cycles:1 Average:725.69 Median:725.69 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 725.7 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 12506.2 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#7] RegExp Cycles:1 Average:41469.39 Median:41469.39 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 41469.4 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#8] Splay Cycles:1 Average:579.22 Median:579.22 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 579.2 17:11:46 INFO - PROCESS | 4221 | 17:11:46 INFO - PROCESS | 4221 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:11:46 INFO - PROCESS | 4221 | Values: 4845.4 17:11:46 INFO - PROCESS | 4221 | -------- Summary: end -------- 17:11:46 INFO - PROCESS | 4221 | 17:11:47 INFO - TEST-INFO | 4221: exit 0 17:11:47 INFO - TEST-OK | v8_7 | took 40728ms 17:11:47 INFO - SUITE-END | took 1212s 17:11:47 INFO - Completed test suite (00:20:12) 17:11:47 INFO - Working with test: dromaeo_css 17:11:47 INFO - Generating results file: dromaeo_css 17:11:47 INFO - Working with test: kraken 17:11:47 INFO - Generating results file: kraken 17:11:47 INFO - javascript benchmark 17:11:47 INFO - Working with test: v8_7 17:11:47 INFO - Generating results file: v8_7 17:11:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:11:47 INFO - process_Request line: dromaeo_css 6782.82 graph.html#tests=[[72,64,43]] 17:11:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:47 INFO - process_Request line: kraken 1522.70 graph.html#tests=[[232,64,43]] 17:11:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:11:47 INFO - process_Request line: v8_7 20323.01 graph.html#tests=[[230,64,43]] 17:11:47 INFO - RETURN: dromaeo_css: 6782.82 17:11:47 INFO - RETURN: kraken: 1522.70 17:11:47 INFO - RETURN: v8_7: 20323.01 17:11:47 INFO - javascript benchmark 17:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3147.638021627512, 3148.7166155046048, 3158.289384888399, 3176.523521471779, 3225.9354812903744, 5164.018836421082, 5183.611229157814, 5190.480951904808, 5202.245674377213, 5233.842984710455, 5234.214867769827, 5247.449017853128, 5264.473552644743, 5342.866428339294, 5363.034653762321, 4755.785989630475, 4781.880452988686, 4839.467658557556, 4878.878028049292, 4929.950700492985, 4756.215224487955, 4811.591014763731, 4846.927296090562, 4847.466778654345, 4907.460179380265, 4675.13510000651, 4757.405324334458, 4781.42622885256, 4787.784549695272, 4846.975765121187, 4783.832565860178, 4786.904261914777, 4788.449328327252, 4794.352762377104, 4824.903501929942, 4772.045590881838, 4777.092352453023, 4777.546133117348, 4789.784459699287, 4805.951940480585, 4949.876253093666, 5034.295198672189, 5075.213341932006, 5086.211637196204, 5170.922436163461, 5676.801311954103, 5684.914726279109, 5706.743196556165, 5707.914381284284, 5718.370979192286, 5547.25112109864, 5782.884342313172, 5784.219130417382, 5785.27684039495, 5797.594168408213, 5256.579473642138, 5269.051570717269, 5296.3379577552805, 5314.5216930476445, 5348.786048558053, 5724.656520608777, 5756.395578464285, 5768.596198266081, 5774.740136693859, 5792.768289268466, 5414.242006119146, 5511.532227901758, 5525.364583072917, 5558.0, 5589.972050139804, 5719.942800571941, 5746.942530574641, 5758.0787074068785, 5782.10377391505, 5805.216295800097, 5729.398413166641, 5738.885222295531, 5745.396733343023, 5754.510866576388, 5766.279215098113, 5479.726013699299, 5482.396936337, 5539.833804985857, 5648.0, 5761.0, 4369.169857727085, 4377.387165796791, 4385.101054283928, 4412.448443944507, 4420.336949457607, 3902.6682731967535, 3916.962005068602, 3936.0, 3943.8028098594955, 3965.167314863911, 5203.219517072469, 5270.183121616155, 5282.049231138355, 5302.681839089667, 5384.892302154013, 5683.460071293221, 5715.114157305541, 5738.856528586819, 5739.13912913058, 5750.734838335559, 5323.86690332737, 5355.3841308249275, 5357.196420536873, 5360.061989151883, 5389.7035663038905, 4735.289706543977, 4774.856754297377, 4790.880227994328, 4807.567318941312, 4859.1010663027455, 5948.881022379528, 5963.344032156459, 5965.492933100648, 5969.074793407029, 6001.729922153513, 5756.971215143897, 5758.0, 5758.193852860519, 5761.423857614205, 5776.046952252831, 5848.912266316093, 5868.559858010752, 5885.411458854252, 5951.256092988377, 5990.610610310316, 5491.890162196813, 5550.222968784454, 5558.3607885092115, 5636.323641162922, 5636.774529018793, 5673.177389278614, 5674.148877668383, 5675.829725108253, 5676.063449530781, 5677.034904066401, 5447.237386765777, 5476.561875050066, 5497.36780270274, 5517.944820551743, 5572.331320241597, 5512.173174023928, 5512.4211957745465, 5512.531434827924, 5515.365732940763, 5518.144687573433, 5314.415414304346, 5429.701366424884, 5436.293281873489, 5439.891202176013, 5481.561475081904, 5441.945580544302, 5491.505764481216, 5523.613347065667, 5554.833354999357, 5600.047991841316, 5326.840194794162, 5329.147336426153, 5348.304720386325, 5352.0, 5353.625246232727], "unit": "score", "name": "dojo.html", "value": 5220.080140832884}, {"lowerIsBetter": false, "replicates": [536.6324068013411, 551.9862003449913, 554.9472800083992, 569.6895192120294, 600.8197540737777, 34789.0, 35539.822300888525, 35938.64061359389, 36027.2794544109, 36073.27853442929, 36178.09554761132, 36228.81885590575, 36336.36486358113, 36367.0, 36809.0, 8270.255676989054, 8547.10255423181, 8548.829023419528, 8619.224269815715, 8638.524881131567, 8264.83470330593, 8372.916270837304, 8434.957825210897, 8435.114312997139, 8480.067192608809, 8281.337493000545, 8343.499390036617, 8455.365847561457, 8483.448575842582, 8486.024107227686, 8420.24217820396, 8450.535220562928, 8481.151884811532, 8492.872606910902, 8494.06565277819, 8338.082810890797, 8483.74548763538, 8483.95758021206, 8487.575621218975, 8494.06565277819, 36831.63168368309, 37167.814160929025, 37251.4412283816, 37266.44100338497, 37399.25201495982, 3237.6924192201704, 3244.383567122263, 3315.5689760331243, 3689.6679298862964, 3895.590962948906, 28118.718812811814, 28233.435331293258, 29239.707602924125, 29278.85360573205, 29339.119826405244, 3952.8023598819946, 3987.461692671481, 3989.900252493682, 4040.676745860324, 4057.310257256244, 252943.0, 253836.0, 254486.0, 254552.0, 254959.72520137465, 49904.75047624738, 50441.49558504442, 54282.0, 54664.453355465936, 61357.0, 57160.0, 57475.71262143746, 57584.13623795647, 57679.13481297784, 57736.422635773946, 12584.244945303128, 12667.30329831868, 12691.809622855664, 12796.93601532005, 12846.871531284754, 9370.344075914756, 9411.811763764686, 9422.434653920787, 9442.95278523603, 9447.952760236154, 18799.0, 18880.622387552172, 19011.429657110308, 19030.904845475685, 19056.904715476612, 7701.961490192513, 7817.0, 7855.803604909923, 7915.248051435105, 7920.0, 943.8442656961524, 954.1889394015031, 957.2676902169845, 959.5921733263335, 1088.8475613414128, 28005.29986750307, 28111.43777124487, 28245.858770706014, 28372.290692732848, 28844.278893027844, 1005.4319309590059, 1049.7900419916048, 1074.5164675895878, 1088.7332603512032, 1149.4138089436692, 14576.854231457763, 14712.55862324132, 14780.48268310604, 14978.700425991638, 14985.175815330043, 311894.0, 315047.0, 315214.0, 316759.0, 316793.0, 50985.23522147171, 51130.74434627803, 51152.48847511552, 51237.231441528405, 51542.22686659703, 1307.5554311534124, 1319.221659221064, 1319.9802002969964, 1342.060557609677, 1344.4151793969654, 26885.86557067202, 27683.0, 27779.583306250828, 27963.300917477227, 28022.2994425141, 44921.0, 45168.096638066396, 45335.31997020113, 45454.77272613616, 45534.316985244586, 281555.0, 281859.26985111664, 281946.0, 282377.0, 283667.0, 30310.393792124476, 30545.694543054284, 30581.08256752301, 30661.54007689842, 31598.210044748146, 36090.27819443649, 36444.27111457809, 36669.44995825118, 36882.0, 37388.0, 31012.379752405275, 31398.529022065144, 31749.0, 32433.0, 32593.0, 32127.196820079684, 32512.187195320304, 32523.51214731828, 32744.50883236801, 33001.50497742488, 33745.32509349848, 34289.0, 34426.655733443346, 34622.30755384828, 35154.64845351514, 27211.86394068017, 29036.0, 30645.23386915345, 30955.0, 31465.213369665027, 24702.0, 24802.875985620678, 24810.751892480843, 24942.62586061174, 25138.24585262445], "unit": "score", "name": "ext.html", "value": 17583.5047042744}, {"lowerIsBetter": false, "replicates": [360.9981950090249, 364.2260197081201, 366.5747732630149, 367.51121009057954, 367.9337719210542, 16282.592935176626, 16876.91561542192, 16983.660326793455, 17110.032346280183, 17754.11229438528, 15403.614909627266, 15629.0, 16046.518604441886, 16094.517164485054, 16270.26783794729, 4866.537678920497, 5082.771275292621, 5108.8211912583065, 5118.155504341779, 5121.5390614844655, 4989.401271847365, 5052.166392545226, 5078.5937125029905, 5181.6113791465605, 5363.570914326864, 3680.2271522980204, 3834.118152824852, 5306.734663266821, 5363.785448582052, 5364.1149210380245, 5408.0535906216255, 5490.3411590608985, 5491.203775452557, 5507.091329930557, 5545.944540554603, 5216.113260745682, 5292.629515933886, 5318.175682769177, 5320.17537281722, 5334.413214546396, 12793.808092878615, 12967.610971670865, 13054.934725326408, 13084.803727944089, 19423.611527769364, 2070.637638413272, 2091.8221951134174, 2112.4718820294925, 2146.2809958663865, 2190.375742913262, 8872.290216782641, 10522.684319470429, 12385.566505172366, 12912.548060817826, 13095.0, 1802.7025540785755, 1848.473185142228, 1889.896055716935, 1907.2943011085988, 1909.9427017189507, 53595.464045359826, 53598.464015359736, 54105.45894541083, 56467.152992705145, 57588.71205643987, 9465.337426380225, 9706.75733106678, 9811.852822207673, 9953.701388958343, 10012.349197302152, 12495.437705303284, 12538.874611253954, 12579.371031448574, 12596.81104783429, 12621.368931553385, 6565.507586930999, 6599.7360105595235, 6617.33826617344, 6640.203175618956, 6642.136522252076, 6137.508999280047, 6269.686515674198, 6371.139896114058, 6455.838604034937, 6499.54503184782, 4443.311286750559, 4476.261416866246, 4495.0, 4515.096980603892, 4527.886802829889, 1835.2292037344348, 1888.2163901980525, 1904.714292856055, 1923.9326623568109, 1935.7386752788193, 419.5720365227512, 434.3484772840739, 442.08267844223366, 445.944256967879, 474.6748477293065, 9969.651062212788, 10370.948145259375, 10822.24244302907, 10949.781004379867, 11090.22368434218, 445.1697584005806, 445.53886727237153, 453.5713750505806, 462.6992454904339, 475.74785363757263, 5780.942190578125, 9175.44947303164, 9916.206703463706, 10066.547005384775, 10236.925122861992, 526632.0, 529388.0, 530892.0, 549027.0, 553596.0, 70447.64776176086, 71081.28918710747, 72077.0, 72523.2747672527, 72636.63681681664, 1098.5715570927346, 1129.870064942542, 1137.624583887315, 1147.6098126636984, 1160.4719852466937, 15116.319765610793, 15218.771718424012, 15246.542603721906, 15283.235838207822, 15592.220388980279, 33595.66404336023, 33706.0, 33834.83082584571, 33882.66117338795, 34788.30423391569, 43862.56137438712, 44337.0, 45097.0, 45194.77402612966, 45667.31499027584, 7296.7081316746735, 7373.29953654402, 7420.628968551443, 7523.586202758901, 7545.50954187976, 9852.655157069468, 11301.491432885376, 11566.42167891619, 11584.829744430572, 11774.234674746114, 9257.398269112486, 9429.858552121861, 9549.331546791658, 9838.26213034011, 9840.55717492729, 8955.0, 9281.907180928105, 9666.03339666056, 9952.054554817281, 10106.090451859369, 9211.170994610517, 9474.57364418589, 9530.094641009093, 9794.853077203705, 9843.852342215016, 7355.5586664800285, 7386.667599958122, 7496.0255166827965, 7562.546247225184, 7625.0, 8557.529335886336, 9066.909330906607, 9364.438133712, 9386.859197112186, 9478.526073696425], "unit": "score", "name": "jquery.html", "value": 7619.302293459247}, {"lowerIsBetter": false, "replicates": [1495.4242616592612, 1511.9546413607593, 1653.2147230065714, 1792.3189188108518, 1806.6179372779818, 7628.694852205912, 7640.656170472328, 7840.0, 7845.882311765328, 7877.80305492363, 7877.606119694006, 7903.802404939879, 7967.92032079679, 7973.720919767809, 7977.04275486941, 2366.25462979161, 2385.654080158376, 2390.486045500217, 2394.760523947609, 2398.9040438382444, 2363.468219650582, 2364.042562762084, 2372.620380739082, 2379.1910750344878, 2426.684531010966, 2216.8448208625405, 2292.7363353214346, 2295.9540809183804, 2351.6354964980455, 2381.9642705359433, 2294.1511640692884, 2295.5638428698494, 2313.7801908818637, 2317.73346065203, 2327.755585663498, 2326.6975293211945, 2339.1345202275265, 2346.5189636124555, 2349.2482405630203, 2355.9646605300936, 7617.46677732559, 7702.614869256515, 7704.9598304228775, 7712.113106992711, 7713.6914523419, 4661.230896902007, 4689.944762428427, 4732.787024583902, 4771.6898401603785, 4783.784729687172, 2969.62879640045, 2973.2566858285427, 2999.9850000749857, 3033.2265272355407, 3070.078976307121, 963.1668606655263, 974.4348277998744, 979.3732011512637, 988.1353815411514, 1024.7950409917971, 10881.727956801064, 10991.340519568852, 10996.890031099747, 11050.834237486444, 11092.778144437147, 4309.513217939806, 4338.609525142752, 4359.542248063971, 4399.406080179135, 4414.09511050234, 8697.608607612672, 8882.289416846637, 8920.955395222982, 8921.107889211027, 8924.464532128093, 4718.150732868048, 4725.9527404726205, 4727.101850648366, 4729.101470720552, 4738.905221895543, 4354.542773008852, 4410.20616289071, 4421.159979603865, 4422.402975598317, 4449.51055383914, 3469.6877281044826, 3496.8950931472095, 3498.8425520851624, 3504.4392897136336, 3523.031166429201, 1095.4303762043692, 1116.0959622705634, 1116.7319843237726, 1123.1800785426685, 1126.099120703434, 1010.6715317521835, 1036.0675392146977, 1075.854759607443, 1147.4492243722893, 1324.9797655804975, 6993.2657071006815, 7005.1944026436595, 7041.788746337618, 7083.114610673666, 7180.1742799578715, 1105.8285965675334, 1116.7096554895786, 1126.5606413498742, 1127.115214556569, 1137.7383201863618, 5591.105423132361, 5681.091025435993, 5684.976704193202, 5687.687177205211, 5695.202671625976, 9342.95328523353, 9391.201747851372, 9739.610415583438, 9777.46223957675, 9793.706188814347, 9493.288003399635, 9571.856422153673, 9595.568199431042, 9631.133198012212, 9655.903440965641, 7232.312930271616, 7287.744928927462, 7458.254174582498, 7466.738664146729, 7500.774976750816, 7079.0, 7115.039469671528, 7135.0, 7160.964195178991, 7167.498275120692, 8291.253787159185, 8377.45546539473, 8600.569971501274, 8625.137486251324, 8657.696980605648, 8606.010308814566, 8814.382993190415, 8838.0, 8846.424982376382, 8877.0, 6662.533622646562, 6773.966130169515, 6809.8638027238185, 6812.489063320171, 6815.250322464624, 7578.545287282781, 7591.3547348475995, 7631.198724133886, 7675.769726908202, 7690.884636730565, 6311.684415779101, 7007.8248043797275, 7210.89183662235, 7266.164391094881, 7331.8533629328185, 6324.588901721373, 6638.867222655616, 6888.0, 7012.053372794811, 7135.607541585055, 6971.058907047483, 6986.54587451814, 7002.0, 7113.430925526049, 7119.964400177966, 6440.806775796734, 6498.74005039812, 6498.772542960974, 6526.184226971629, 6580.572262803094, 6634.867302653824, 6661.2006559213205, 6668.599884006975, 6674.43267322283, 6676.0987266718375], "unit": "score", "name": "mootools.html", "value": 4516.461666081353}, {"lowerIsBetter": false, "replicates": [338.14280798176617, 350.70365541117764, 352.05824419677356, 355.91991801844574, 357.19096247000533, 6159.969200154004, 6235.158253635758, 6270.090836828668, 6350.142730731362, 6360.840978975522, 6123.295820980588, 6132.969335153318, 6246.344133865936, 6274.905876411857, 6296.937030629692, 4768.690035147722, 4774.092922344761, 4774.140654682155, 4775.068861571995, 4777.808887644499, 4776.761161941889, 4786.904261914759, 4789.976050119762, 4791.856244312658, 4794.304825800257, 4660.6970546914345, 4745.454272758642, 4748.121597504455, 4749.097671442432, 4750.0024994750975, 4699.95300047002, 4736.029114031615, 4737.076270127326, 4742.027884283713, 4757.024809913959, 4104.445899803548, 4112.938305925413, 4114.629683328485, 4118.567550407194, 4125.154343359604, 5892.675902825343, 5918.437748413894, 5949.167116603679, 5956.195913551658, 5965.164876917235, 5408.783648654088, 5514.255575497296, 5519.641223320512, 5522.3649280332875, 5523.7238138093335, 6599.0, 6599.835004124887, 6600.80197594073, 6605.9339406605795, 6610.603363798139, 4523.683342166049, 4528.479224889114, 4536.77316134192, 4539.568740969636, 4553.840615578472, 6597.373249541286, 6839.965800171017, 6930.549514281555, 6960.095187625627, 6961.025456436103, 4559.065391594715, 4560.293154561048, 4604.723716576949, 4644.814207431732, 4645.233536466513, 4586.3579098926175, 4598.471175814757, 4604.240300350405, 4605.792739326738, 4608.792604332813, 5352.9732351338, 5395.21769343443, 5416.864578385572, 5417.756200970965, 5417.864553386197, 6420.357964203542, 6553.63954982471, 6562.114114594468, 6568.441682456949, 6609.570377925419, 1598.9360425582847, 1614.7900772899447, 1635.1006946179791, 1639.442589519569, 1641.0317912431722, 1087.3856271206744, 1111.4831603304501, 1112.6995711157942, 1116.1071143085499, 1119.9888001119884, 6168.814935551941, 6198.411150940744, 6199.56603037783, 6199.659018754011, 6209.844753881189, 6582.901256481156, 6595.373439523238, 6659.433948114464, 6664.733410663616, 6667.199936007613, 6087.36082711309, 6111.908321375183, 6153.323134455206, 6185.938140618626, 6191.0, 3621.6921561667555, 3646.5077214575695, 3655.908602284964, 3658.63413658632, 3665.486831843544, 6936.687849046805, 6984.825379365557, 6991.545549539263, 7017.157941047107, 7024.964875175591, 6738.393544581011, 6836.38472537474, 6864.553804002724, 6867.862642747117, 6884.831278147368, 6810.557313774688, 6956.513044086865, 6962.930370696329, 6971.0, 6980.0, 6555.573887697285, 6591.868162636816, 6641.535092543476, 6670.332966703291, 6685.130932978682, 6486.805395838132, 6494.6752662367635, 6551.6069035858, 6595.736170553124, 6620.271770105188, 6969.477289203432, 6981.057557229709, 6989.0, 6990.370866622028, 6999.335063168991, 4603.263477843529, 4605.102005108972, 4606.6314694825005, 4613.146567884952, 4617.6536759742485, 6653.700583473658, 6663.13379260693, 6675.632840193836, 6681.69932353055, 6745.156855393076, 6598.868022639424, 6649.368310010541, 6651.50113741481, 6653.933460665525, 6656.001599760075, 6511.479081673549, 6563.7702680407865, 6565.573237739532, 6641.601503909781, 6658.3674550917585, 6231.127642130196, 6501.772437964649, 6502.837429064311, 6513.674316284072, 6538.738450461929, 6529.379708927644, 6665.933340666531, 6673.532852700265, 6677.666116694243, 6687.799366019027, 6342.556021078481, 6373.107764913008, 6375.107484952017, 6432.2602900667025, 6462.353764623688], "unit": "score", "name": "prototype.html", "value": 4933.359449700635}, {"lowerIsBetter": false, "replicates": [846.678262260341, 857.618359829876, 857.9914200857993, 863.8920134983128, 864.9999999999998, 13398.1961082335, 13494.325283735798, 13546.322683865805, 13549.458021679146, 13577.796333055, 12684.492620295177, 12743.745125097492, 12811.551595694129, 12836.807447888266, 12860.67848303793, 768.4313607930119, 771.8687823070092, 780.9258120478573, 786.3905473258213, 790.0637744273026, 797.6171437709903, 798.0543056478064, 801.3789313282224, 802.4623502253474, 805.6012273924416, 830.6760363458257, 832.8042909916165, 849.5030407211789, 850.6129710981488, 852.667459690718, 840.0381563110204, 841.6885752271637, 845.7082306604211, 846.6317152038882, 847.3009766942297, 623.1431781300712, 626.1203009771233, 629.6033498895666, 629.8834715577588, 631.4348657951108, 12691.0, 12709.364531773374, 12820.807687884597, 12869.613911582574, 12888.484460621565, 12463.875361246362, 12629.494820207181, 12694.746105077938, 12981.286029268387, 13039.217646941119, 9438.952805235998, 9757.804843903154, 9814.116729494379, 9947.452890091043, 10443.74519957383, 3497.1082373994723, 3506.68439840413, 3548.822558872046, 3563.5367402237803, 3566.6076731559506, 48384.0, 48732.756336218095, 48796.756016220046, 48972.26541601843, 49033.50966490325, 9688.757781055388, 9805.852912206323, 9915.355501892354, 9939.155171810333, 10226.0, 17675.646487070186, 17701.557461063578, 17706.29174833018, 17734.91132544329, 17743.911280443772, 7056.294370562902, 7317.15852676949, 7328.193898671142, 7363.116426028911, 7680.308772210527, 4165.396017577495, 4211.873643790691, 4237.470316210473, 4241.63946064588, 4242.957570424256, 3028.046165457874, 3069.3707789903015, 3069.754419646423, 3070.3552254026904, 3072.7080927311868, 564.7119968815933, 569.6041251330286, 577.3302968556538, 577.5408550202599, 580.4804699793661, 591.3229352391488, 635.4725577770532, 637.9664942792613, 651.6709061923698, 666.7666316789085, 8331.66673333072, 8682.43696268672, 8686.174813392843, 8752.737417877473, 8876.689315873913, 519.9246109314129, 632.7785275153659, 664.62448716476, 678.2776343194482, 685.5201359048685, 4053.0, 4065.6340929316502, 4067.593240675909, 4132.8140233689555, 4191.538930717618, 54507.0, 54538.72730636401, 54682.0, 54795.0, 55180.724096380065, 46708.53291467042, 48605.270920936215, 49613.75193124011, 51997.48002520002, 52126.73936630293, 43869.341959870624, 44701.32948005782, 44830.068692443805, 45052.774736126106, 45248.999999999345, 8442.788930276793, 8518.23335899772, 9015.639374424949, 9029.77425564366, 9035.186833185046, 31930.36139277155, 32778.92897266259, 32873.67126328706, 33389.33221335511, 33755.81854635076, 36976.445353319185, 41133.794331028155, 41554.79222603868, 41669.0, 42322.576774231864, 10811.295561888577, 10839.349639021684, 10915.345079295268, 11056.613018544313, 11249.606263780728, 12226.755464890475, 12370.81443778362, 12375.133740638068, 12462.376881155724, 12843.807342889677, 11105.444727763741, 11296.378699171624, 11420.143489238175, 11679.591214307458, 11787.292762434281, 11292.717682057686, 11593.768124637292, 11743.530258789553, 11830.585929492427, 12088.75822483563, 11257.268277561932, 11346.546138154381, 11750.0, 11766.411679415824, 11831.290122592673, 9332.30007749408, 9582.616695332108, 9618.51907404641, 9637.614495420385, 9931.602735890772, 8994.0, 9150.542472876197, 9360.0, 9583.904160958302, 9970.501474926079], "unit": "score", "name": "yui.html", "value": 6248.708169072972}], "name": "dromaeo_css", "value": 6782.824689365342}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 112.0, 113.0, 124.0, 112.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 146.0, 170.0, 133.0, 153.0, 155.0, 129.0, 168.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 163.0, 162.0, 165.0, 170.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 71.0, 76.0, 75.0, 137.0, 71.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 141.0, 99.0, 97.0, 96.0, 141.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 58.0, 60.0, 57.0, 59.0, 60.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 69.0, 69.0, 68.0, 70.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 85.0, 85.0, 87.0, 93.0, 91.0, 87.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [116.0, 120.0, 124.0, 124.0, 120.0, 129.0, 120.0, 125.0, 131.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [143.0, 159.0, 162.0, 157.0, 144.0, 152.0, 142.0, 156.0, 147.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1522.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "Richards", "value": 211.14126199999998}, {"lowerIsBetter": false, "replicates": [189.53752843062927], "unit": "score", "name": "DeltaBlue", "value": 348.8385680000001}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [725.6894049346879], "unit": "score", "name": "Earley", "value": 918.3860139999999}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [41469.38775510204], "unit": "score", "name": "RegExp", "value": 21.96765009842518}, {"lowerIsBetter": false, "replicates": [579.219288174512], "unit": "score", "name": "Splay", "value": 140.69110208126858}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20323.011355766404}]} 17:11:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20323.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6782.82"}}} 17:11:47 INFO - Return code: 0 17:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:11:47 INFO - # TBPL SUCCESS # 17:11:47 INFO - Running post-action listener: _resource_record_post_action 17:11:47 INFO - Running post-run listener: _resource_record_post_run 17:11:48 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10407936; Write bytes: 436957184; Read time: 2280; Write time: 397360 17:11:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1613824; Read time: 0; Write time: 104 17:11:48 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8646656; Write bytes: 379125760; Read time: 2216; Write time: 376384 17:11:48 INFO - Running post-run listener: _upload_blobber_files 17:11:48 INFO - Blob upload gear active. 17:11:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:11:48 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 17:11:48 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:11:48 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:11:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:50 INFO - (blobuploader) - INFO - Done attempting. 17:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:51 INFO - (blobuploader) - INFO - Done attempting. 17:11:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:51 INFO - Return code: 0 17:11:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:11:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ba238836653e4d261d3ede7c630ad4eab1acbe159fb1c5424d82943e7f9151981a5eb2f0518a670da293f350f4c38acc8c290741e3a700d3d244bd6d824e931", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af878a217aa89aa49a6e3026d34fce92eb38fd08c7cf9aaaa778bdbb79b2cf8880ae8f0ed83fe293b26cba61897d70e7b8bc485ec3d99da7a9eca4a3e438d0e"} 17:11:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:11:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:11:51 INFO - Contents: 17:11:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ba238836653e4d261d3ede7c630ad4eab1acbe159fb1c5424d82943e7f9151981a5eb2f0518a670da293f350f4c38acc8c290741e3a700d3d244bd6d824e931", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af878a217aa89aa49a6e3026d34fce92eb38fd08c7cf9aaaa778bdbb79b2cf8880ae8f0ed83fe293b26cba61897d70e7b8bc485ec3d99da7a9eca4a3e438d0e"} 17:11:51 INFO - Copying logs to upload dir... 17:11:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.519961 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-12 17:11:51.090924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 17:11:51.096505) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 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/Fx-Team/sha512/3ba238836653e4d261d3ede7c630ad4eab1acbe159fb1c5424d82943e7f9151981a5eb2f0518a670da293f350f4c38acc8c290741e3a700d3d244bd6d824e931", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af878a217aa89aa49a6e3026d34fce92eb38fd08c7cf9aaaa778bdbb79b2cf8880ae8f0ed83fe293b26cba61897d70e7b8bc485ec3d99da7a9eca4a3e438d0e"} build_url:https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/NKNbseglRDa06DIvzDo29w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ba238836653e4d261d3ede7c630ad4eab1acbe159fb1c5424d82943e7f9151981a5eb2f0518a670da293f350f4c38acc8c290741e3a700d3d244bd6d824e931", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3af878a217aa89aa49a6e3026d34fce92eb38fd08c7cf9aaaa778bdbb79b2cf8880ae8f0ed83fe293b26cba61897d70e7b8bc485ec3d99da7a9eca4a3e438d0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 17:11:51.121104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 17:11:51.121416) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1452645923.458832-566684024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 17:11:51.205924) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 17:11:51.206260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 17:11:51.206545) ========= ========= Total master_lag: 0.19 =========