builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1451584164.84 results: success (0) buildid: 20151231073530 builduid: ebf96010af5f46568760a0a33f17503c revision: 95b69afcce38658e99e25158657cb376e0bd9bcc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.838935) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.839452) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.839807) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.912610) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.913052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.992817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:24.993117) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.054181) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.054481) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.054847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.055168) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 09:49: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.7M=0s 2015-12-31 09:49:25 (71.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.233754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.234112) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018357 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.283743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.284181) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 95b69afcce38658e99e25158657cb376e0bd9bcc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 95b69afcce38658e99e25158657cb376e0bd9bcc --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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 09:49:25,566 truncating revision to first 12 chars 2015-12-31 09:49:25,566 Setting DEBUG logging. 2015-12-31 09:49:25,566 attempt 1/10 2015-12-31 09:49:25,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/95b69afcce38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 09:49:25,789 unpacking tar archive at: mozilla-inbound-95b69afcce38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.487611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.784752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.785095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.831389) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.831825) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 09:49:25.832384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-31 09:49:25.833039) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:26 INFO - MultiFileLogger online at 20151231 09:49:26 in /builds/slave/test-pgo 09:49:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:49:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:49:26 INFO - {'append_to_log': False, 09:49:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:49:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:49:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:49:26 INFO - 'branch': 'Mozilla-Inbound', 09:49:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:26 INFO - 'config_files': ('talos/linux_config.py',), 09:49:26 INFO - 'default_actions': ('clobber', 09:49:26 INFO - 'read-buildbot-config', 09:49:26 INFO - 'download-and-extract', 09:49:26 INFO - 'populate-webroot', 09:49:26 INFO - 'create-virtualenv', 09:49:26 INFO - 'install', 09:49:26 INFO - 'run-tests'), 09:49:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:26 INFO - 'download_minidump_stackwalk': True, 09:49:26 INFO - 'download_symbols': 'ondemand', 09:49:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:26 INFO - 'installer_path': 'installer.exe', 09:49:26 INFO - 'log_level': 'info', 09:49:26 INFO - 'log_name': 'talos', 09:49:26 INFO - 'log_to_console': True, 09:49:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:26 INFO - 'opt_config_files': (), 09:49:26 INFO - 'pip_index': False, 09:49:26 INFO - 'sps_profile': False, 09:49:26 INFO - 'sps_profile_interval': 0, 09:49:26 INFO - 'suite': 'dromaeojs-e10s', 09:49:26 INFO - 'system_bits': '32', 09:49:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:26 INFO - 'title': 'talos-linux64-ix-041', 09:49:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:26 INFO - 'use_talos_json': True, 09:49:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:49:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:26 INFO - 'work_dir': 'build'} 09:49:26 INFO - ##### 09:49:26 INFO - ##### Running clobber step. 09:49:26 INFO - ##### 09:49:26 INFO - Running pre-action listener: _resource_record_pre_action 09:49:26 INFO - Running main action method: clobber 09:49:26 INFO - rmtree: /builds/slave/test-pgo/build 09:49:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:49:26 INFO - Running post-action listener: _resource_record_post_action 09:49:26 INFO - ##### 09:49:26 INFO - ##### Running read-buildbot-config step. 09:49:26 INFO - ##### 09:49:26 INFO - Running pre-action listener: _resource_record_pre_action 09:49:26 INFO - Running main action method: read_buildbot_config 09:49:26 INFO - Using buildbot properties: 09:49:26 INFO - { 09:49:26 INFO - "project": "", 09:49:26 INFO - "product": "firefox", 09:49:26 INFO - "script_repo_revision": "production", 09:49:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:49:26 INFO - "repository": "", 09:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:49:26 INFO - "buildid": "20151231073530", 09:49:26 INFO - "pgo_build": "True", 09:49:26 INFO - "basedir": "/builds/slave/test-pgo", 09:49:26 INFO - "buildnumber": 574, 09:49:26 INFO - "slavename": "talos-linux64-ix-041", 09:49:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:49:26 INFO - "platform": "ubuntu64_hw", 09:49:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:49:26 INFO - "branch": "mozilla-inbound", 09:49:26 INFO - "repo_path": "integration/mozilla-inbound", 09:49:26 INFO - "revision": "95b69afcce38658e99e25158657cb376e0bd9bcc", 09:49:26 INFO - "stage_platform": "linux64-pgo", 09:49:26 INFO - "builduid": "ebf96010af5f46568760a0a33f17503c", 09:49:26 INFO - "slavebuilddir": "test" 09:49:26 INFO - } 09:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:49:26 INFO - Running post-action listener: _resource_record_post_action 09:49:26 INFO - ##### 09:49:26 INFO - ##### Running download-and-extract step. 09:49:26 INFO - ##### 09:49:26 INFO - Running pre-action listener: _resource_record_pre_action 09:49:26 INFO - Running main action method: download_and_extract 09:49:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:49:26 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')]} 09:49:26 INFO - https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/test_packages.json 09:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/test_packages.json 09:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:49:28 INFO - Downloaded 1302 bytes. 09:49:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:49:28 INFO - Using the following test package requirements: 09:49:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'jsshell-linux-x86_64.zip'], 09:49:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:49:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:49:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:28 INFO - https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:29 INFO - Downloaded 23196172 bytes. 09:49:29 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 09:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:29 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 09:49:31 INFO - Return code: 0 09:49:31 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 09:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:31 INFO - https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:32 INFO - Downloaded 23196172 bytes. 09:49:32 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 09:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:32 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 09:49:33 INFO - Return code: 0 09:49: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')]} 09:49:33 INFO - https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:34 INFO - Downloaded 11132285 bytes. 09:49:34 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 09:49:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:34 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 09:49:34 INFO - Return code: 0 09:49:34 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')]} 09:49:34 INFO - https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:49:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/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 09:49:37 INFO - Downloaded 54959962 bytes. 09:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:37 INFO - mkdir: /builds/slave/test-pgo/properties 09:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:49:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:49:37 INFO - Contents: 09:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:37 INFO - Running post-action listener: _resource_record_post_action 09:49:37 INFO - Running post-action listener: set_extra_try_arguments 09:49:37 INFO - ##### 09:49:37 INFO - ##### Running populate-webroot step. 09:49:37 INFO - ##### 09:49:37 INFO - Running pre-action listener: _resource_record_pre_action 09:49:37 INFO - Running main action method: populate_webroot 09:49:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:37 INFO - '--tppagecycles', 09:49:37 INFO - '7'], 09:49:37 INFO - 'tests': ['tsvgm']}}, 09:49:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:49:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'tests': ['damp', 'tps']}, 09:49:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['damp', 'tps']}, 09:49:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:49:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:37 INFO - 'other': {'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'other_l64': {'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'other_nol64': {'tests': ['a11yr', 09:49:37 INFO - 'ts_paint', 09:49:37 INFO - 'tpaint', 09:49:37 INFO - 'sessionrestore', 09:49:37 INFO - 'sessionrestore_no_auto_restore']}, 09:49:37 INFO - 'svgr': {'tests': ['tsvgx', 09:49:37 INFO - 'tsvgr_opacity', 09:49:37 INFO - 'tart', 09:49:37 INFO - 'tscrollx', 09:49:37 INFO - 'cart']}, 09:49:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['tsvgx', 09:49:37 INFO - 'tsvgr_opacity', 09:49:37 INFO - 'tart', 09:49:37 INFO - 'tscrollx', 09:49:37 INFO - 'cart']}, 09:49:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'tests': ['tp5o']}, 09:49:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'talos_options': ['--e10s'], 09:49:37 INFO - 'tests': ['tp5o']}, 09:49:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'talos_options': ['--xperf_path', 09:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:37 INFO - 'tests': ['tp5n']}, 09:49:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:37 INFO - 'talos_options': ['--e10s', 09:49:37 INFO - '--xperf_path', 09:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:37 INFO - 'tests': ['tp5n']}}, 09:49:37 INFO - 'talos.zip': {'path': '', 09:49:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:37 INFO - Running post-action listener: _resource_record_post_action 09:49:37 INFO - ##### 09:49:37 INFO - ##### Running create-virtualenv step. 09:49:37 INFO - ##### 09:49:37 INFO - Running pre-action listener: _resource_record_pre_action 09:49:37 INFO - Running main action method: create_virtualenv 09:49:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:49:37 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 09:49:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:49:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:37 INFO - Using real prefix '/usr' 09:49:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:49:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:39 INFO - Installing pip.................done. 09:49:39 INFO - Return code: 0 09:49:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:49:39 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')]} 09:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:39 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')]} 09:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:39 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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:39 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 09:49:39 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 09:49:39 INFO - Using env: {'DISPLAY': ':0', 09:49:39 INFO - 'HOME': '/home/cltbld', 09:49:39 INFO - 'LANG': 'en_US.UTF-8', 09:49:39 INFO - 'LANGUAGE': 'en_US:en', 09:49:39 INFO - 'LOGNAME': 'cltbld', 09:49:39 INFO - 'MAIL': '/var/mail/cltbld', 09:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:39 INFO - 'MOZ_NO_REMOTE': '1', 09:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:39 INFO - 'NO_EM_RESTART': '1', 09:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:39 INFO - 'SHELL': '/bin/bash', 09:49:39 INFO - 'SHLVL': '1', 09:49:39 INFO - 'TERM': 'linux', 09:49:39 INFO - 'TMOUT': '86400', 09:49:39 INFO - 'USER': 'cltbld', 09:49:39 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:39 INFO - '_': '/tools/buildbot/bin/python'} 09:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:40 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 09:49:40 INFO - Cleaning up... 09:49:40 INFO - Return code: 0 09:49:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:49:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:49:40 INFO - Using env: {'DISPLAY': ':0', 09:49:40 INFO - 'HOME': '/home/cltbld', 09:49:40 INFO - 'LANG': 'en_US.UTF-8', 09:49:40 INFO - 'LANGUAGE': 'en_US:en', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MAIL': '/var/mail/cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SHLVL': '1', 09:49:40 INFO - 'TERM': 'linux', 09:49:40 INFO - 'TMOUT': '86400', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - '_': '/tools/buildbot/bin/python'} 09:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:40 INFO - Downloading/unpacking psutil>=0.7.1 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:49:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:49:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:42 INFO - Installing collected packages: psutil 09:49:42 INFO - Running setup.py install for psutil 09:49:42 INFO - building 'psutil._psutil_linux' extension 09:49:42 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 09:49:42 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 09:49:42 INFO - building 'psutil._psutil_posix' extension 09:49:42 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 09:49:42 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 09:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:42 INFO - Successfully installed psutil 09:49:42 INFO - Cleaning up... 09:49:42 INFO - Return code: 0 09:49:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:49:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:49:42 INFO - Using env: {'DISPLAY': ':0', 09:49:42 INFO - 'HOME': '/home/cltbld', 09:49:42 INFO - 'LANG': 'en_US.UTF-8', 09:49:42 INFO - 'LANGUAGE': 'en_US:en', 09:49:42 INFO - 'LOGNAME': 'cltbld', 09:49:42 INFO - 'MAIL': '/var/mail/cltbld', 09:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:42 INFO - 'MOZ_NO_REMOTE': '1', 09:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:42 INFO - 'NO_EM_RESTART': '1', 09:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:42 INFO - 'SHELL': '/bin/bash', 09:49:42 INFO - 'SHLVL': '1', 09:49:42 INFO - 'TERM': 'linux', 09:49:42 INFO - 'TMOUT': '86400', 09:49:42 INFO - 'USER': 'cltbld', 09:49:42 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:42 INFO - '_': '/tools/buildbot/bin/python'} 09:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:44 INFO - Installing collected packages: mozsystemmonitor 09:49:44 INFO - Running setup.py install for mozsystemmonitor 09:49:44 INFO - Successfully installed mozsystemmonitor 09:49:44 INFO - Cleaning up... 09:49:44 INFO - Return code: 0 09:49:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:49:44 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')]} 09:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 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')]} 09:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:44 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 09:49:44 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 09:49:44 INFO - Using env: {'DISPLAY': ':0', 09:49:44 INFO - 'HOME': '/home/cltbld', 09:49:44 INFO - 'LANG': 'en_US.UTF-8', 09:49:44 INFO - 'LANGUAGE': 'en_US:en', 09:49:44 INFO - 'LOGNAME': 'cltbld', 09:49:44 INFO - 'MAIL': '/var/mail/cltbld', 09:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:44 INFO - 'MOZ_NO_REMOTE': '1', 09:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:44 INFO - 'NO_EM_RESTART': '1', 09:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:44 INFO - 'SHELL': '/bin/bash', 09:49:44 INFO - 'SHLVL': '1', 09:49:44 INFO - 'TERM': 'linux', 09:49:44 INFO - 'TMOUT': '86400', 09:49:44 INFO - 'USER': 'cltbld', 09:49:44 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:44 INFO - '_': '/tools/buildbot/bin/python'} 09:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:49:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:46 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 09:49:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:49:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:49:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 INFO - Downloading docopt-0.6.1.tar.gz 09:49:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:49:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:47 INFO - Running setup.py install for blobuploader 09:49:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:49:47 INFO - Running setup.py install for requests 09:49:47 INFO - Running setup.py install for docopt 09:49:47 INFO - Successfully installed blobuploader requests docopt 09:49:47 INFO - Cleaning up... 09:49:48 INFO - Return code: 0 09:49:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:48 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 09:49:48 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 09:49:48 INFO - Using env: {'DISPLAY': ':0', 09:49:48 INFO - 'HOME': '/home/cltbld', 09:49:48 INFO - 'LANG': 'en_US.UTF-8', 09:49:48 INFO - 'LANGUAGE': 'en_US:en', 09:49:48 INFO - 'LOGNAME': 'cltbld', 09:49:48 INFO - 'MAIL': '/var/mail/cltbld', 09:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:48 INFO - 'MOZ_NO_REMOTE': '1', 09:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:48 INFO - 'NO_EM_RESTART': '1', 09:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:48 INFO - 'SHELL': '/bin/bash', 09:49:48 INFO - 'SHLVL': '1', 09:49:48 INFO - 'TERM': 'linux', 09:49:48 INFO - 'TMOUT': '86400', 09:49:48 INFO - 'USER': 'cltbld', 09:49:48 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:48 INFO - '_': '/tools/buildbot/bin/python'} 09:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:48 INFO - Running setup.py (path:/tmp/pip-Lb926u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:48 INFO - Running setup.py (path:/tmp/pip-jH6ckm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:48 INFO - Running setup.py (path:/tmp/pip-FcnIQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:48 INFO - Running setup.py (path:/tmp/pip-vkuSLj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:48 INFO - Running setup.py (path:/tmp/pip-VNDI3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:48 INFO - Running setup.py (path:/tmp/pip-jaY54J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:48 INFO - Running setup.py (path:/tmp/pip-VShT_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:48 INFO - Running setup.py (path:/tmp/pip-SOgYdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:48 INFO - Running setup.py (path:/tmp/pip-lJNyEk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:48 INFO - Running setup.py (path:/tmp/pip-FlBcno-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:48 INFO - Running setup.py (path:/tmp/pip-djaSv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:49 INFO - Running setup.py (path:/tmp/pip-F7wjRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:49 INFO - Running setup.py (path:/tmp/pip-6_z6b6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:49 INFO - Running setup.py (path:/tmp/pip-aUxV4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:49 INFO - Running setup.py (path:/tmp/pip-szvTP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:49 INFO - Running setup.py (path:/tmp/pip-yjzQ7Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:49 INFO - Running setup.py (path:/tmp/pip-pUz2v1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:49 INFO - Running setup.py install for manifestparser 09:49:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:49:49 INFO - Running setup.py install for mozcrash 09:49:49 INFO - Running setup.py install for mozdebug 09:49:49 INFO - Running setup.py install for mozdevice 09:49:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:49:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:49:49 INFO - Running setup.py install for mozfile 09:49:49 INFO - Running setup.py install for mozhttpd 09:49:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozinfo 09:49:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozInstall 09:49:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozleak 09:49:50 INFO - Running setup.py install for mozlog 09:49:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for moznetwork 09:49:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozprocess 09:49:50 INFO - Running setup.py install for mozprofile 09:49:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozrunner 09:49:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:49:50 INFO - Running setup.py install for mozscreenshot 09:49:51 INFO - Running setup.py install for moztest 09:49:51 INFO - Running setup.py install for mozversion 09:49:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:49:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:51 INFO - Cleaning up... 09:49:51 INFO - Return code: 0 09:49:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:51 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 09:49:51 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 09:49:51 INFO - Using env: {'DISPLAY': ':0', 09:49:51 INFO - 'HOME': '/home/cltbld', 09:49:51 INFO - 'LANG': 'en_US.UTF-8', 09:49:51 INFO - 'LANGUAGE': 'en_US:en', 09:49:51 INFO - 'LOGNAME': 'cltbld', 09:49:51 INFO - 'MAIL': '/var/mail/cltbld', 09:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:51 INFO - 'MOZ_NO_REMOTE': '1', 09:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:51 INFO - 'NO_EM_RESTART': '1', 09:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:51 INFO - 'SHELL': '/bin/bash', 09:49:51 INFO - 'SHLVL': '1', 09:49:51 INFO - 'TERM': 'linux', 09:49:51 INFO - 'TMOUT': '86400', 09:49:51 INFO - 'USER': 'cltbld', 09:49:51 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:51 INFO - '_': '/tools/buildbot/bin/python'} 09:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:51 INFO - Running setup.py (path:/tmp/pip-MS2GNS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:51 INFO - Running setup.py (path:/tmp/pip-hhqT_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:51 INFO - Running setup.py (path:/tmp/pip-8bHdMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:51 INFO - Running setup.py (path:/tmp/pip-2Du7M_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:51 INFO - Running setup.py (path:/tmp/pip-QFAWn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:51 INFO - Running setup.py (path:/tmp/pip-8P6zYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:51 INFO - Running setup.py (path:/tmp/pip-40dD_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:51 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)) 09:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:51 INFO - Running setup.py (path:/tmp/pip-2YtSwz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:52 INFO - Running setup.py (path:/tmp/pip-XfgZBG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:52 INFO - Running setup.py (path:/tmp/pip-tS7uuU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:52 INFO - Running setup.py (path:/tmp/pip-mdTNUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:52 INFO - Running setup.py (path:/tmp/pip-iorVTc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:52 INFO - Running setup.py (path:/tmp/pip-IK3m_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:52 INFO - Running setup.py (path:/tmp/pip-JgAr78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:52 INFO - Running setup.py (path:/tmp/pip-QrAoBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:52 INFO - Running setup.py (path:/tmp/pip-eQ15RS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:52 INFO - Running setup.py (path:/tmp/pip-W5Kpm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:52 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)) 09:49:52 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)) 09:49:52 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)) 09:49:52 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)) 09:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:52 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)) 09:49:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:54 INFO - Downloading blessings-1.5.1.tar.gz 09:49:54 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 09:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:54 INFO - Installing collected packages: blessings 09:49:54 INFO - Running setup.py install for blessings 09:49:54 INFO - Successfully installed blessings 09:49:54 INFO - Cleaning up... 09:49:54 INFO - Return code: 0 09:49:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:49:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:54 INFO - Reading from file tmpfile_stdout 09:49:54 INFO - Current package versions: 09:49:54 INFO - argparse == 1.2.1 09:49:54 INFO - blessings == 1.5.1 09:49:54 INFO - blobuploader == 1.2.4 09:49:54 INFO - docopt == 0.6.1 09:49:54 INFO - manifestparser == 1.1 09:49:54 INFO - mozInstall == 1.12 09:49:54 INFO - mozcrash == 0.16 09:49:54 INFO - mozdebug == 0.1 09:49:54 INFO - mozdevice == 0.47 09:49:54 INFO - mozfile == 1.2 09:49:54 INFO - mozhttpd == 0.7 09:49:54 INFO - mozinfo == 0.9 09:49:54 INFO - mozleak == 0.1 09:49:54 INFO - mozlog == 3.1 09:49:54 INFO - moznetwork == 0.27 09:49:54 INFO - mozprocess == 0.22 09:49:54 INFO - mozprofile == 0.28 09:49:54 INFO - mozrunner == 6.11 09:49:54 INFO - mozscreenshot == 0.1 09:49:54 INFO - mozsystemmonitor == 0.0 09:49:54 INFO - moztest == 0.7 09:49:54 INFO - mozversion == 1.4 09:49:54 INFO - psutil == 3.1.1 09:49:54 INFO - requests == 1.2.3 09:49:54 INFO - wsgiref == 0.1.2 09:49:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '-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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:54 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 09:49:54 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 09:49:54 INFO - Using env: {'DISPLAY': ':0', 09:49:54 INFO - 'HOME': '/home/cltbld', 09:49:54 INFO - 'LANG': 'en_US.UTF-8', 09:49:54 INFO - 'LANGUAGE': 'en_US:en', 09:49:54 INFO - 'LOGNAME': 'cltbld', 09:49:54 INFO - 'MAIL': '/var/mail/cltbld', 09:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:54 INFO - 'MOZ_NO_REMOTE': '1', 09:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:54 INFO - 'NO_EM_RESTART': '1', 09:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:54 INFO - 'SHELL': '/bin/bash', 09:49:54 INFO - 'SHLVL': '1', 09:49:54 INFO - 'TERM': 'linux', 09:49:54 INFO - 'TMOUT': '86400', 09:49:54 INFO - 'USER': 'cltbld', 09:49:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:54 INFO - '_': '/tools/buildbot/bin/python'} 09:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 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)) 09:49:55 INFO - Cleaning up... 09:49:55 INFO - Return code: 0 09:49:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:49:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:49:55 INFO - Using env: {'DISPLAY': ':0', 09:49:55 INFO - 'HOME': '/home/cltbld', 09:49:55 INFO - 'LANG': 'en_US.UTF-8', 09:49:55 INFO - 'LANGUAGE': 'en_US:en', 09:49:55 INFO - 'LOGNAME': 'cltbld', 09:49:55 INFO - 'MAIL': '/var/mail/cltbld', 09:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:55 INFO - 'MOZ_NO_REMOTE': '1', 09:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:55 INFO - 'NO_EM_RESTART': '1', 09:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:55 INFO - 'SHELL': '/bin/bash', 09:49:55 INFO - 'SHLVL': '1', 09:49:55 INFO - 'TERM': 'linux', 09:49:55 INFO - 'TMOUT': '86400', 09:49:55 INFO - 'USER': 'cltbld', 09:49:55 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:55 INFO - '_': '/tools/buildbot/bin/python'} 09:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:55 INFO - Downloading/unpacking jsonschema 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:56 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 09:49:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:57 INFO - warning: no files found matching '*.txt' 09:49:57 INFO - no previously-included directories found matching 'build' 09:49:57 INFO - no previously-included directories found matching 'dist' 09:49:57 INFO - no previously-included directories found matching '.git*' 09:49:57 INFO - Installing collected packages: jsonschema, functools32 09:49:57 INFO - Running setup.py install for functools32 09:49:57 INFO - warning: no files found matching '*.txt' 09:49:57 INFO - no previously-included directories found matching 'build' 09:49:57 INFO - no previously-included directories found matching 'dist' 09:49:57 INFO - no previously-included directories found matching '.git*' 09:49:57 INFO - Successfully installed jsonschema functools32 09:49:57 INFO - Cleaning up... 09:49:57 INFO - Return code: 0 09:49:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:49:57 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')]} 09:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:57 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')]} 09:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:57 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 0x7efeff85bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, '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': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', '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 09:49:57 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 09:49:57 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 09:49:57 INFO - Using env: {'DISPLAY': ':0', 09:49:57 INFO - 'HOME': '/home/cltbld', 09:49:57 INFO - 'LANG': 'en_US.UTF-8', 09:49:57 INFO - 'LANGUAGE': 'en_US:en', 09:49:57 INFO - 'LOGNAME': 'cltbld', 09:49:57 INFO - 'MAIL': '/var/mail/cltbld', 09:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:57 INFO - 'MOZ_NO_REMOTE': '1', 09:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:57 INFO - 'NO_EM_RESTART': '1', 09:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:57 INFO - 'SHELL': '/bin/bash', 09:49:57 INFO - 'SHLVL': '1', 09:49:57 INFO - 'TERM': 'linux', 09:49:57 INFO - 'TMOUT': '86400', 09:49:57 INFO - 'USER': 'cltbld', 09:49:57 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:57 INFO - '_': '/tools/buildbot/bin/python'} 09:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:57 INFO - Downloading/unpacking flake8 09:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:59 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 09:49:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:59 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 09:49:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 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 09:49:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:59 INFO - no previously-included directories found matching 'docs/_build' 09:49:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:50:00 INFO - Running setup.py install for pep8 09:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:00 INFO - no previously-included directories found matching 'docs/_build' 09:50:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:50:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:50:00 INFO - Cleaning up... 09:50:00 INFO - Return code: 0 09:50:00 INFO - Running post-action listener: _resource_record_post_action 09:50:00 INFO - Running post-action listener: _start_resource_monitoring 09:50:00 INFO - Starting resource monitoring. 09:50:00 INFO - ##### 09:50:00 INFO - ##### Running install step. 09:50:00 INFO - ##### 09:50:00 INFO - Running pre-action listener: _resource_record_pre_action 09:50:00 INFO - Running main action method: install 09:50:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:00 INFO - Reading from file tmpfile_stdout 09:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:50:00 INFO - Reading from file tmpfile_stdout 09:50:00 INFO - Output received: 09:50:00 INFO - Usage: mozinstall [options] installer 09:50:00 INFO - Options: 09:50:00 INFO - -h, --help show this help message and exit 09:50:00 INFO - -d DEST, --destination=DEST 09:50:00 INFO - Directory to install application into. [default: 09:50:00 INFO - "/builds/slave/test-pgo"] 09:50:00 INFO - --app=APP Application being installed. [default: firefox] 09:50:00 INFO - mkdir: /builds/slave/test-pgo/build/application 09:50:00 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'] 09:50:00 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 09:50:16 INFO - Reading from file tmpfile_stdout 09:50:16 INFO - Output received: 09:50:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:50:16 INFO - Running post-action listener: _resource_record_post_action 09:50:16 INFO - ##### 09:50:16 INFO - ##### Running run-tests step. 09:50:16 INFO - ##### 09:50:16 INFO - Running pre-action listener: _resource_record_pre_action 09:50:16 INFO - Running main action method: run_tests 09:50:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:50:16 INFO - Python 2.7.3 09:50:16 INFO - Return code: 0 09:50:16 INFO - grabbing minidump binary from tooltool 09:50:16 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')]} 09:50:16 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 0x14647f0>, '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 0x13d02d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d0760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:50:16 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 09:50:16 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 09:50:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:16 INFO - Return code: 0 09:50:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:50:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:50:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:50:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:50:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:50:17 INFO - Return code: 0 09:50:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 09:50:17 INFO - Using env: {'DISPLAY': ':0', 09:50:17 INFO - 'HOME': '/home/cltbld', 09:50:17 INFO - 'LANG': 'en_US.UTF-8', 09:50:17 INFO - 'LANGUAGE': 'en_US:en', 09:50:17 INFO - 'LOGNAME': 'cltbld', 09:50:17 INFO - 'MAIL': '/var/mail/cltbld', 09:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:17 INFO - 'MOZ_NO_REMOTE': '1', 09:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:17 INFO - 'NO_EM_RESTART': '1', 09:50:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:50:17 INFO - 'SHELL': '/bin/bash', 09:50:17 INFO - 'SHLVL': '1', 09:50:17 INFO - 'TERM': 'linux', 09:50:17 INFO - 'TMOUT': '86400', 09:50:17 INFO - 'USER': 'cltbld', 09:50:17 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722', 09:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:17 INFO - '_': '/tools/buildbot/bin/python'} 09:50:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 09:50:17 INFO - mozversion application_buildid: 20151231073530 09:50:17 INFO - mozversion application_changeset: 95b69afcce38658e99e25158657cb376e0bd9bcc 09:50:17 INFO - mozversion application_display_name: Nightly 09:50:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:17 INFO - mozversion application_name: Firefox 09:50:17 INFO - mozversion application_remotingname: firefox 09:50:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:50:17 INFO - mozversion application_vendor: Mozilla 09:50:17 INFO - mozversion application_version: 46.0a1 09:50:17 INFO - mozversion platform_buildid: 20151231073530 09:50:17 INFO - mozversion platform_changeset: 95b69afcce38658e99e25158657cb376e0bd9bcc 09:50:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:50:17 INFO - mozversion platform_version: 46.0a1 09:50:17 INFO - using testdate: 1451584217 09:50:17 INFO - actual date: 1451584217 09:50:17 INFO - starting webserver on 'localhost:38258' 09:50:17 INFO - SUITE-START | Running 3 tests 09:50:17 INFO - TEST-START | dromaeo_css 09:50:17 INFO - operating with platform_type : linux_ 09:50:17 INFO - Initialising browser for dromaeo_css test... 09:50:17 INFO - TEST-INFO | started process 10964 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp37vAz6/profile http://localhost:38258/getInfo.html) 09:50:22 INFO - PROCESS | 10964 | __metrics Screen width/height:1600/1200 09:50:22 INFO - PROCESS | 10964 | colorDepth:24 09:50:22 INFO - PROCESS | 10964 | Browser inner width/height: 1024/697 09:50:22 INFO - PROCESS | 10964 | __metrics 09:50:22 INFO - PROCESS | 10964 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:50:23 INFO - TEST-INFO | 10964: exit 0 09:50:23 INFO - Browser initialized. 09:50:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:23 INFO - TEST-INFO | started process 11094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp37vAz6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:35 INFO - PROCESS | 11094 | RSS: Main: 149712896 09:50:35 INFO - PROCESS | 11094 | 09:51:24 INFO - PROCESS | 11094 | 1451584284785 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] 09:53:33 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38258/tests/dromaeo/cssquery-ext.html) 09:53:34 INFO - PROCESS | 11094 | RSS: Main: 156418048 09:53:34 INFO - PROCESS | 11094 | 09:56:36 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-ext.html (next: http://localhost:38258/tests/dromaeo/cssquery-jquery.html) 09:56:37 INFO - PROCESS | 11094 | RSS: Main: 153423872 09:56:37 INFO - PROCESS | 11094 | 09:59:38 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38258/tests/dromaeo/cssquery-mootools.html) 09:59:39 INFO - PROCESS | 11094 | RSS: Main: 153169920 09:59:39 INFO - PROCESS | 11094 | 10:02:41 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38258/tests/dromaeo/cssquery-prototype.html) 10:02:41 INFO - PROCESS | 11094 | RSS: Main: 152002560 10:02:41 INFO - PROCESS | 11094 | 10:05:44 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38258/tests/dromaeo/cssquery-yui.html) 10:05:44 INFO - PROCESS | 11094 | RSS: Main: 152518656 10:05:44 INFO - PROCESS | 11094 | 10:08:46 INFO - PROCESS | 11094 | Cycle 1(1): loaded http://localhost:38258/tests/dromaeo/cssquery-yui.html (next: http://localhost:38258/tests/dromaeo/cssquery-dojo.html) 10:08:47 INFO - PROCESS | 11094 | RSS: Main: 154853376 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | __start_tp_report 10:08:47 INFO - PROCESS | 11094 | _x_x_mozilla_page_load 10:08:47 INFO - PROCESS | 11094 | _x_x_mozilla_page_load_details 10:08:47 INFO - PROCESS | 11094 | |i|pagename|runs| 10:08:47 INFO - PROCESS | 11094 | |0;dojo.html;3168.889088881889;3198.5681932939046;3223.9032829015136;3228.4188846007723;3236.9190770230744;5108.540231379176;5109.693418394894;5121.718305493197;5124.897502049961;5206.245094461301;5208.973955130219;5264.447233040523;5276.393214780302;5276.472352764722;5279.234510995903;4853.029394121181;4856.441509226449;4894.119058569456;4915.655904086715;4933.260010998343;4878.146324393235;4889.242167464049;4898.28974798654;4900.950990490103;4907.411110666725;4523.8642840714665;4689.132510485554;4828.396450443694;4840.1771698810935;4852.393450818648;4818.59041981432;4843.757812109416;4863.10032643962;4877.756112194412;4883.12103821312;4722.079194557063;4824.179889418807;4829.975850120762;4833.951660483385;4897.191963326047;5061.746912654353;5062.67092638981;5094.974525127351;5103.336566246364;5164.793408263665;5487.42382049887;5573.916391254134;5575.581831362664;5580.107182850765;5608.270924779793;5597.944020559783;5632.859178520529;5647.209390685307;5686.459786320293;5769.624974376652;5366.570674346043;5381.0583147948955;5382.91925621116;5384.353877534721;5403.081476149064;5890.705464726832;5895.587308888336;5895.764169433261;5897.115432685046;5902.881942361215;5392.379876314196;5494.066008778517;5508.779648814003;5616.943830561724;5656.406077361818;5666.744996475169;5683.715814209273;5685.289338832646;5698.458646428583;5713.628614140068;5519.586031047687;5564.998300305984;5606.943930560724;5609.270794796732;5614.887702245932;5547.583931205176;5565.02612042899;5571.582131340166;5664.8867022659315;5693.459121383462;4193.39195816611;4206.242876282298;4209.2633789086785;4217.987682956068;4248.362745588187;3791.639794219545;3805.238952209569;3806.847726090981;3809.5619003814363;3829.4064420014943;5270.025045366619;5274.208868669731;5315.973420132875;5333.413324534298;5380.542653874464;5630.690312032795;5664.405237450091;5670.631408958405;5686.061799803069;5687.431256874363;5187.4553171916405;5316.73416329182;5318;5324.494173053554;5386.865328366822;4630.976845115752;4720.362751028636;4785.306130611042;4813.4945830687975;4829.5653391194965;5925.644461332334;5926.940730592725;5944.375840536768;5945.583809133405;5947.881042379215;5585.944140558705;5709.600327977002;5722.685252311163;5737.139429085671;5797.565182611237;5843.065109582446;5954.970225148846;5956.940430595639;5965.28416590012;5980.790672326448;5674.886502269849;5712.11462223356;5713.22871412354;5715.171300161536;5726.141078838207;5507.889842203053;5604.439556044526;5635.774569017193;5714.885702285847;5805.796797112081;5649.774009039593;5656.264685590847;5659.349174844946;5666.744996475086;5672.290963629546;5618.522425593706;5627.803026894039;5636.971815140898;5640.689762063126;5644.6613203207935;5351.5183633471615;5474.8905021898545;5482.150266708666;5493.450654934474;5496.7526461308535;5466.316710411199;5565.944340556704;5626.915596266142;5642.040853054908;5673.602847800615;5346.037713211659;5358.4105748366865;5371.060064488777;5371.516563509146;5385.676859388449 10:08:47 INFO - PROCESS | 11094 | |1;ext.html;532.3558494221991;566.9262995810546;574.0241589298195;592.4786188154424;607.5018484842428;34418;34822.78120265788;34873;35115.473267901005;35120.47319290213;35487.11282217939;35765.642343576554;36133.638663613354;36182.276354472895;36249.63750362496;8205.22050405212;8300.418970672055;8371.372147088961;8372.079071302152;8409;8104.149064348247;8181.263686268235;8189.181081891793;8234.341252699769;8261.545614991173;8223.383246256524;8345.83308333833;8357.707480238192;8369.748907532754;8371.330293576499;8338.790875323075;8404.537750423724;8408.663653453854;8421.115782842806;8461.53461559614;8255.545944973024;8327.875081873777;8335.54154521501;8423.915760842374;8468.618912148968;35939.64060359389;35965;36144.63855361439;36390.27219455596;36392;3158.1788734928855;3189.4953039941106;3268.0686004488607;3424.9486257706153;3495.4756786481976;28710.282242943886;28845.711542884514;29021.709782902322;29313.413731725246;29542.113736587937;3955.960440395588;3956.742811717229;3983.40248962655;4010.7593544387137;4065.3495440729343;248143;248631;248787;248894;249689;57133.14300285499;57686;57721.42278577245;57881.13178302329;57912.42087579155;65099.67450162719;65760.34239657638;65876.6706166466;65909;66121;14739.55781326562;14943.701125977419;14952.327145278488;14958.401663933539;14966.32651530662;11960.342181180118;11981.28112313264;12073.396330183456;12083.39583020863;12095.032397408362;19757.209711611664;20139.49651258701;20289.898550507154;20374.083166257555;20378.286759963627;7819.218078192135;7829.29536341732;7942.404319676048;8048.315893149031;8078.959605202054;910.3263584947091;917.1287277086794;1040.2250323508883;1042.7966546523508;1063.8297872340543;28576.285592860346;29089.563656545168;30133.397332053235;31069.378612427627;33112.3377532448;1031.4997226345217;1053.3627155570923;1067.3489171605315;1086.2450596835124;1097.5225776787124;14857.554273371816;14907.627309317137;14931.402743890123;15101.169435680924;15136.848631513763;359372;363431;363887;364329;364716;52458.475415246125;52979.470205298225;52992.73503632457;53043.20435193475;53072.46927530675;1313.947442102305;1348.2449828096298;1363.3115276785359;1364.7270545890863;1368.8699573540498;28303.71696283093;28597.28506787347;29010.709892900803;29016.65233992303;29105.85447072751;45157.77421112874;45598;45829.31256031229;45861.541384585726;46051.53948460473;291640;293972;296871;296912;297068;27179.72820271772;28145;30553.388932221675;31671.366572667957;32359.51460728044;36050.4592431119;36241.46981627297;36574.634253657125;36986.26027479489;37041.62958370382;31207.687923120477;31717.841410792797;33874.49188262129;34593.30813383769;34838.47742283817;33856.49215261724;34466;34705.65294347024;34774;34788.82605586956;33993;37420.43869342017;38380.616193837704;38671.41992870165;38700.22599547937;28107.718922811328;30462.238444039078;33894.3221135571;34955;35460.29079418449;24502.26493205207;24921.376965576004;25532.61701074448;25738;25811.741882581686 10:08:47 INFO - PROCESS | 11094 | |2;jquery.html;364.3841907176871;369.77074213987333;370.6071564142009;373.19203923505614;373.43984023964055;11585.6524304271;11984.520619175222;16137.677246455078;16922.74615880761;17594.208260628286;17271.481855544323;17326.220320085595;17350.219240134193;17478.563035924075;17534.649307013853;6061.878762424749;6197.349278325779;6226.533010024266;6231.127642130083;6239.157713708637;5638.830835074934;5818.621789583684;6072.908906366408;6108.419700128503;6163.291221509517;6073.665948372838;6146.231721034871;6186.133941248207;6206.565540412173;6428.067930150125;6270.153529273581;6297.968510157443;6344.999999999977;6352.078948552457;6447.194100737408;6428.485721142298;6444.709988050549;6459.450946669539;6466.708998095097;6467.676616169219;21361.35915922525;22145.55708885813;22318.665220021714;22420.215292464847;22986.195483158175;2269.943251418711;2293.334932869466;2296.59809533331;2343.4024323797494;2485.3289611804894;13830.585082447542;14151.292435378293;14431.783523247159;14561.271936403138;14668.633284167874;1923.384516954575;1974.6149500847341;1990.7810140884492;2013.5904866593296;2045.4375046862083;62541;67236.66381668109;67912.66043669799;68723;69107;14801.111933284037;15243.16162611067;15253.313600887986;15363.23183840826;15387.307571159101;23918.162864299666;23957.963573096134;23977.28068157958;24121.396965076012;24123.15568955113;8895.688650897317;8903.06517815633;8942.150495702897;8961.283097352196;9183.862242066374;7460;7557.848843023219;7559.357454616419;7576.659050342748;7593.278638529331;7527.096748390229;7627.923720762832;7642.579658118746;7646.082470103624;7646.311831935152;1820.8270214329618;2973.435047340998;2988.701129886994;3035.6357237131688;3088.7065728755733;826.396730386821;839.7816567692444;862.9525376104249;991.5884907763198;1020.260311274335;15808.92095539515;15853;15988.600284992735;16031.919840400724;16315;933.290699068699;934.4486752815872;958.3722661656626;963.9566219519999;1022.7238645565656;9159.313051521163;9505.239580833517;9619.230461563198;10035.69892903214;10112.797744045078;423447;451362;493727;496576;499998;70176.298237018;70276.29723702697;73550.63224683842;73815.63092184505;74694.25305746873;478.2921276510784;493.62977766674993;493.98024079036435;495.7719449053476;496.34234639103335;10174.389536627827;10181.287309888534;10282.794344113225;10324;10340.069393754296;31412;32292.515612265364;33061;33713.494297585064;34718.30563388667;41121.58878411297;41154.1769164621;41626.58373416348;43768;43913;9307.860382094139;9592.856107158259;9691.757706057406;9842.409455432697;9849.704508864745;16485.752713709542;16740.916295418447;16933.915330423762;16954;17419.82580174233;13936.512222072179;13981.650458738613;14106.435742570593;14204.147751134966;14415.927920360751;14213.360398782286;14431.78352324695;14828.184449855362;14984.40062397492;15135.318910649268;14790.556283311518;15124;15244.847551524343;15431.768523471932;15541.37834486653;9211;9646.228301735984;9971.05274998874;9978.401295922267;10051.547680354255;10168.745781355525;12364.1963272387;14168.149911005372;14398;14419.85580144227 10:08:47 INFO - PROCESS | 11094 | |3;mootools.html;1421.658801887547;1433.2833583208392;1553.533939818055;1695.3557648093722;1724.2585688154097;7194.3165399287045;7322.340989310967;7324.926750732498;7382.261773822615;7480;7415.962920185391;7434.739784107557;7436.1820199777985;7476.738314159005;7479.962600186991;2183.8908054597246;2206.6138425775507;2226.365485836537;2234.3743751749535;2235.9217427390045;2192.7697591752876;2196.3850121965797;2291.2438895164555;2295.380247333219;2298.195631528968;2182.2907555044594;2212.524307273936;2226.9199438272426;2228.4206106412366;2238.9552208955893;2221.566794475078;2234.1398561553838;2270.4664403865077;2272.6363781795;2274.1812947338944;2184.6286131357706;2196.560687862434;2222.20000799712;2241.8318626102946;2245.7305123385136;7293.52592081513;7370.078740157481;7374.410047196211;7382.815429614249;7384.889226661604;4381.058072514393;4440.689151759379;4473.798679059418;4484.506704262529;4495.910081798378;2894.131760471871;3000.1749518882266;3019.064090132044;3032.36320372722;3064.2798942248555;946.7775072857942;949.848024316113;965.8454647256475;987.0573602209872;1005.1456262177164;10197.694069177862;10232.283740138193;10239.078482936571;10258.333208341508;10259.974002599754;3934.940975885364;3954.940675889864;3979.243943650697;4015.819288132041;4027.9798601006805;8372;8381.07808141104;8395.412321137463;8400.159984001551;8431.451955622864;4416;4416.205083085011;4426.800793964279;4447;4469.575390337913;4100.384942258625;4112.444819949328;4123.8556650517085;4124.752514849119;4131.07050913548;3265.8367081645824;3270.2314955985325;3279;3282.983585082059;3316.9336613268083;987.6691308411619;989.1098011789447;990.8166989106894;991.8809742830906;996.2776986684596;953.756792018031;994.7363948553639;1013.4578000769553;1082.3614067700096;1223.1804690857148;6641.33586641332;6659.234188068434;6669.199696036507;6670.833229169212;6690.197176338773;604.5194070713793;615.8791000379356;618.7617767159586;645.3514218210669;782.4210084537515;5272.3076461948895;5451;5465.781368745285;5470.53500452466;5481.643693159932;8671.869921951176;8727.996280427706;8898.288136949159;8925.598348074222;8974.28205743539;8989.910100899038;8990.86513702282;9047.230985366317;9058.094190581021;9063;7092.5389849659605;7121.394681452031;7153.3561979421065;7174.677139528734;7192.892106618405;6736.831579210559;6819.0794242778575;6828.214755303204;6839.179298484214;6913.308669133046;7628.80927976805;7832.451728378959;7843.450958432855;7864.567448790372;7907;7841.764747057598;7902.051753789352;7963.800904977422;8080.191980801873;8089.352851771727;6565.409113179837;6605.933940660532;6619.404253617197;6650.102236198245;6776.627285499345;7103.467239957127;7322.0847394075745;7327.706891724271;7333.6699848508015;7358.264173582599;6802.693878775368;6842.076319696777;6928.515003949675;6939.618320992394;6953.20038195614;6495.123158373748;6578.80263592093;6631.469482441296;6691.364320389555;6741.73033078691;6625.006249062679;6635.8009259722285;6657.367550082734;6658.7336506539195;6660.467162627075;5974.342822289458;6066.666333351708;6090.451859332681;6101.176341193882;6123.938760612336;6216.098665693539;6219.533534984804;6287.874242515216;6288.151099601679;6304.18045654062 10:08:47 INFO - PROCESS | 11094 | |4;prototype.html;339.25533454068324;345.9757816952813;350.41305812763625;352.59099444644215;356.4528448831043;6232.563720539564;6251.281102673194;6261.311255761868;6318.9999999999945;6366.045093236017;6194.69026548673;6216.751329946808;6230.626162430257;6251.843703907404;6257;4719.952800472003;4725.787339569728;4728.692634978724;4731.763411829412;4733.337332773414;4724.102420540104;4727.479977202505;4732.290156476539;4737.573618374346;4738;4548.363229147922;4608.239640459337;4614.700044497114;4622.929250642895;4688.953110468903;4667.836625718118;4674.111918735446;4689.015306785579;4690.179218636725;4696.295555666643;4043.0498832774274;4049.8380064797375;4049.959500405017;4056.472658554369;4060.20825938942;5909.320428150775;5920.111983202511;5927.318358388798;5938.376470470625;5948.791792287249;5261.657992230493;5391.892162156774;5431.049566325917;5438.075527160392;5444.482774136451;6588.110605068302;6589.242237142742;6591.93408065918;6602.8349291268105;6613.107230523914;4486.282194848841;4490.932636010462;4497.527759585229;4498.730076195438;4499.842505512292;6794.45644348451;6862.279460656609;6922.342377474182;6928.757493487754;6929.896051559231;4643.11780761661;4654.953450465452;4662.883427914261;4673.976630116827;4683.360823711673;4730.408698912636;4732.834350797774;4734;4736.1474934511425;4749.430068391815;5470.070088085035;5474.972625136849;5480.287562616834;5492.47821456961;5496.340439147248;6452.257990331172;6627.602343859384;6650.9667451662435;6656.900146497806;6664.933350666432;1651.7694317733126;1669.3823285384242;1673.1132499774894;1677.8154403015658;1678.7146185148554;1037.7820657661825;1053.6680945502142;1086.1690806533009;1088.2001728729379;1090.7327704712395;6286.9056964145575;6300.810975670645;6315.305316415191;6319.905201421982;6330.39861213184;6825.283345248777;6850.486213533905;6851.38337549613;6860.0738900248825;6869.725210991504;6189.721462534197;6295.433410993032;6311.842203944938;6321.6207027577575;6322.114903913456;3701.685356744653;3716.2939041582013;3747.5502939647417;3758.755680880734;3762.398016317376;7222.458315626244;7232.240614735482;7236.782896513113;7247.094113235846;7259.274072592699;6977.686004129826;7102.964485177645;7112.92887071133;7118.110236220473;7129.572225666477;7194.964025179841;7235.0232718583375;7238.420926325882;7252.782416527512;7252.948322493209;6817.795466136024;6875.312468753084;6875.656217189221;6875.759348422781;6885.208201056943;6719.428848547928;6802.081718967876;6839.384455399038;6848.623325717133;6849.691763870737;7193.5324203926575;7203.963980180066;7226.494145409771;7228.060352154186;7233.132024157135;4640.187967105676;4665.323528088476;4665.906681866411;4677.953220467752;4684.906301874012;6796.18445786489;6806.489513286622;6932.896006560007;6937;6946.2011868635755;6685.498587606046;6693.531452798257;6708.42978346846;6710.698018589273;6732.629705366252;6548.705308261045;6686.197656281277;6711.261761206361;6713.899291510729;6717.16035495563;6529.836754081186;6531.281559028598;6542.738290468518;6546.116274302908;6546.869062618816;6758.256591774999;6759.831004224934;6761.898571521529;6763.8985415219795;6771;6375.394337537927;6528.314526974599;6583.407493325432;6585.045168450643;6586.868262634816 10:08:47 INFO - PROCESS | 11094 | |5;yui.html;830.5639539241894;840.6469282901182;843.510763757021;845.5476320168711;866.7616405488494;12577;12728.554500592458;12850.678733031667;12858.292793896344;12892;11992;12052.21660592063;13357.398917048731;13538.864611353883;13582.93208533956;789.8894154818315;795.8607243732353;800.1358532784578;800.6957356204634;801.2988634944423;804.1837534902049;810.2424233341815;810.5866008335732;811.4725428471481;811.5860910935406;847.8558645030329;853.5945425922669;853.7950891785989;854.1543871567166;858.3262139220712;841.0622156295748;845.6363763581658;847.3856454070811;849.6601359456236;849.8980122385323;614.241411856357;618.3599974026905;619.9969000155015;620.2773768559667;622.9657368844712;13546.390412431465;13547.322633868365;13588.25264610446;13717.245551494663;13757.449702011907;12393.62819115428;12454.383877407756;12543.498260069586;12887.420066097047;12897.548585799452;9956.900430995742;10226;10525.36847789135;10621.362718236931;10668.733281668021;3588.910277243064;3624.5469316335457;3691.9261614767825;3740.1584643455276;3780.0549862534367;42197.999999999694;42441;42775.144497110196;42862.142757145;46629.601111966695;9759.170470509944;9864.556094975744;9947.303688741864;9991.150752186;10036.498175091363;16445.424410145828;16620.6675866482;16677.666446671;16694.49916502507;16734.16329183536;7477.140128885248;7489.887651685229;7614;7683.308502234826;7900.249476299742;4307.396964424983;4309.612134907873;4344.9348259776125;4424.800883960165;4428.6678499112695;2982.8806847726282;2984.015274959258;2994.131701806495;3009.5786589877434;3014.487537118695;520.6433592988815;537.0306596593186;542.9294191755047;551.0219360634906;551.2255281329739;615.9568830181844;651.90547370631;660.4881217056724;678.9679686876019;684.1414025398193;7771.417143714244;7774.144844067148;7947.3642108631175;7995.960020199862;8362.89154218909;582.5834528312278;618.1099217127412;654.7381047581006;666.4468491152332;671.7111641993891;3641.599424063351;3961.3661814109605;3989.3617021276455;4006.982543640898;4070.816813243411;57722.71138644364;59700.70149649224;59791.70104149451;59920.70039649861;59975;45340.77329613331;46084.308735369;46500.5349946503;50042.24936625954;50505.74747126241;46867;47615.76192119087;47839;48833.511664883605;49024.754876225394;8213.219744124299;8613.913860861561;8636.265917397091;8758.868616970878;8770.517621530877;33430;33757.83121084379;34029.82985085059;34097.82951085229;34353.48469772905;40111.3983290245;40250.396244056945;40265.59734402619;41873.58126418697;42618;11226.663200103683;11688.590899318484;11719.824202637137;11860;12498.562550310695;10908.34549927007;11403.600873969372;11713.707157321136;12216.511339546318;12445.128840981044;11465.31208127515;11486.13853960973;11674.416279186176;11875.703107422383;12231.816522752344;10869.782604348027;10928.836067458835;11001.559937602406;11407.372594507382;11671.183017188716;11204.775904481701;11254.774904502028;11255;11379.601713939972;11714.589989350332;9963.651272205438;10287.177025838064;10330.638427654996;10336.431496267778;10757.784844303227;9256.72229833106;9425.62297508092;9560.61757529691;9721.368111072758;10159 10:08:47 INFO - PROCESS | 11094 | __end_tp_report 10:08:47 INFO - PROCESS | 11094 | __start_cc_report 10:08:47 INFO - PROCESS | 11094 | _x_x_mozilla_cycle_collect,317 10:08:47 INFO - PROCESS | 11094 | __end_cc_report 10:08:47 INFO - PROCESS | 11094 | __startTimestamp1451585327154__endTimestamp 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | ------- Summary: start ------- 10:08:47 INFO - PROCESS | 11094 | Number of tests: 6 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#0] dojo.html Cycles:165 Average:5259.93 Median:5466.32 stddev:603.43 (11.0%) stddev-sans-first:582.56 10:08:47 INFO - PROCESS | 11094 | Values: 3168.9 3198.6 3223.9 3228.4 3236.9 5108.5 5109.7 5121.7 5124.9 5206.2 5209.0 5264.4 5276.4 5276.5 5279.2 4853.0 4856.4 4894.1 4915.7 4933.3 4878.1 4889.2 4898.3 4901.0 4907.4 4523.9 4689.1 4828.4 4840.2 4852.4 4818.6 4843.8 4863.1 4877.8 4883.1 4722.1 4824.2 4830.0 4834.0 4897.2 5061.7 5062.7 5095.0 5103.3 5164.8 5487.4 5573.9 5575.6 5580.1 5608.3 5597.9 5632.9 5647.2 5686.5 5769.6 5366.6 5381.1 5382.9 5384.4 5403.1 5890.7 5895.6 5895.8 5897.1 5902.9 5392.4 5494.1 5508.8 5616.9 5656.4 5666.7 5683.7 5685.3 5698.5 5713.6 5519.6 5565.0 5606.9 5609.3 5614.9 5547.6 5565.0 5571.6 5664.9 5693.5 4193.4 4206.2 4209.3 4218.0 4248.4 3791.6 3805.2 3806.8 3809.6 3829.4 5270.0 5274.2 5316.0 5333.4 5380.5 5630.7 5664.4 5670.6 5686.1 5687.4 5187.5 5316.7 5318.0 5324.5 5386.9 4631.0 4720.4 4785.3 4813.5 4829.6 5925.6 5926.9 5944.4 5945.6 5947.9 5585.9 5709.6 5722.7 5737.1 5797.6 5843.1 5955.0 5956.9 5965.3 5980.8 5674.9 5712.1 5713.2 5715.2 5726.1 5507.9 5604.4 5635.8 5714.9 5805.8 5649.8 5656.3 5659.3 5666.7 5672.3 5618.5 5627.8 5637.0 5640.7 5644.7 5351.5 5474.9 5482.2 5493.5 5496.8 5466.3 5565.9 5626.9 5642.0 5673.6 5346.0 5358.4 5371.1 5371.5 5385.7 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#1] ext.html Cycles:180 Average:46589.18 Median:35035.24 stddev:80311.90 (229.2%) stddev-sans-first:80462.75 10:08:47 INFO - PROCESS | 11094 | Values: 532.4 566.9 574.0 592.5 607.5 34418.0 34822.8 34873.0 35115.5 35120.5 35487.1 35765.6 36133.6 36182.3 36249.6 8205.2 8300.4 8371.4 8372.1 8409.0 8104.1 8181.3 8189.2 8234.3 8261.5 8223.4 8345.8 8357.7 8369.7 8371.3 8338.8 8404.5 8408.7 8421.1 8461.5 8255.5 8327.9 8335.5 8423.9 8468.6 35939.6 35965.0 36144.6 36390.3 36392.0 3158.2 3189.5 3268.1 3424.9 3495.5 28710.3 28845.7 29021.7 29313.4 29542.1 3956.0 3956.7 3983.4 4010.8 4065.3 248143.0 248631.0 248787.0 248894.0 249689.0 57133.1 57686.0 57721.4 57881.1 57912.4 65099.7 65760.3 65876.7 65909.0 66121.0 14739.6 14943.7 14952.3 14958.4 14966.3 11960.3 11981.3 12073.4 12083.4 12095.0 19757.2 20139.5 20289.9 20374.1 20378.3 7819.2 7829.3 7942.4 8048.3 8079.0 910.3 917.1 1040.2 1042.8 1063.8 28576.3 29089.6 30133.4 31069.4 33112.3 1031.5 1053.4 1067.3 1086.2 1097.5 14857.6 14907.6 14931.4 15101.2 15136.8 359372.0 363431.0 363887.0 364329.0 364716.0 52458.5 52979.5 52992.7 53043.2 53072.5 1313.9 1348.2 1363.3 1364.7 1368.9 28303.7 28597.3 29010.7 29016.7 29105.9 45157.8 45598.0 45829.3 45861.5 46051.5 291640.0 293972.0 296871.0 296912.0 297068.0 27179.7 28145.0 30553.4 31671.4 32359.5 36050.5 36241.5 36574.6 36986.3 37041.6 31207.7 31717.8 33874.5 34593.3 34838.5 33856.5 34466.0 34705.7 34774.0 34788.8 33993.0 37420.4 38380.6 38671.4 38700.2 28107.7 30462.2 33894.3 34955.0 35460.3 24502.3 24921.4 25532.6 25738.0 25811.7 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#2] jquery.html Cycles:180 Average:27517.44 Median:367.08 stddev:77364.49 (21075.8%) stddev-sans-first:77554.65 10:08:47 INFO - PROCESS | 11094 | Values: 364.4 369.8 370.6 373.2 373.4 11585.7 11984.5 16137.7 16922.7 17594.2 17271.5 17326.2 17350.2 17478.6 17534.6 6061.9 6197.3 6226.5 6231.1 6239.2 5638.8 5818.6 6072.9 6108.4 6163.3 6073.7 6146.2 6186.1 6206.6 6428.1 6270.2 6298.0 6345.0 6352.1 6447.2 6428.5 6444.7 6459.5 6466.7 6467.7 21361.4 22145.6 22318.7 22420.2 22986.2 2269.9 2293.3 2296.6 2343.4 2485.3 13830.6 14151.3 14431.8 14561.3 14668.6 1923.4 1974.6 1990.8 2013.6 2045.4 62541.0 67236.7 67912.7 68723.0 69107.0 14801.1 15243.2 15253.3 15363.2 15387.3 23918.2 23958.0 23977.3 24121.4 24123.2 8895.7 8903.1 8942.2 8961.3 9183.9 7460.0 7557.8 7559.4 7576.7 7593.3 7527.1 7627.9 7642.6 7646.1 7646.3 1820.8 2973.4 2988.7 3035.6 3088.7 826.4 839.8 863.0 991.6 1020.3 15808.9 15853.0 15988.6 16031.9 16315.0 933.3 934.4 958.4 964.0 1022.7 9159.3 9505.2 9619.2 10035.7 10112.8 423447.0 451362.0 493727.0 496576.0 499998.0 70176.3 70276.3 73550.6 73815.6 74694.3 478.3 493.6 494.0 495.8 496.3 10174.4 10181.3 10282.8 10324.0 10340.1 31412.0 32292.5 33061.0 33713.5 34718.3 41121.6 41154.2 41626.6 43768.0 43913.0 9307.9 9592.9 9691.8 9842.4 9849.7 16485.8 16740.9 16933.9 16954.0 17419.8 13936.5 13981.7 14106.4 14204.1 14415.9 14213.4 14431.8 14828.2 14984.4 15135.3 14790.6 15124.0 15244.8 15431.8 15541.4 9211.0 9646.2 9971.1 9978.4 10051.5 10168.7 12364.2 14168.1 14398.0 14419.9 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#3] mootools.html Cycles:180 Average:5183.95 Median:6592.37 stddev:2692.09 (40.8%) stddev-sans-first:2684.79 10:08:47 INFO - PROCESS | 11094 | Values: 1421.7 1433.3 1553.5 1695.4 1724.3 7194.3 7322.3 7324.9 7382.3 7480.0 7416.0 7434.7 7436.2 7476.7 7480.0 2183.9 2206.6 2226.4 2234.4 2235.9 2192.8 2196.4 2291.2 2295.4 2298.2 2182.3 2212.5 2226.9 2228.4 2239.0 2221.6 2234.1 2270.5 2272.6 2274.2 2184.6 2196.6 2222.2 2241.8 2245.7 7293.5 7370.1 7374.4 7382.8 7384.9 4381.1 4440.7 4473.8 4484.5 4495.9 2894.1 3000.2 3019.1 3032.4 3064.3 946.8 949.8 965.8 987.1 1005.1 10197.7 10232.3 10239.1 10258.3 10260.0 3934.9 3954.9 3979.2 4015.8 4028.0 8372.0 8381.1 8395.4 8400.2 8431.5 4416.0 4416.2 4426.8 4447.0 4469.6 4100.4 4112.4 4123.9 4124.8 4131.1 3265.8 3270.2 3279.0 3283.0 3316.9 987.7 989.1 990.8 991.9 996.3 953.8 994.7 1013.5 1082.4 1223.2 6641.3 6659.2 6669.2 6670.8 6690.2 604.5 615.9 618.8 645.4 782.4 5272.3 5451.0 5465.8 5470.5 5481.6 8671.9 8728.0 8898.3 8925.6 8974.3 8989.9 8990.9 9047.2 9058.1 9063.0 7092.5 7121.4 7153.4 7174.7 7192.9 6736.8 6819.1 6828.2 6839.2 6913.3 7628.8 7832.5 7843.5 7864.6 7907.0 7841.8 7902.1 7963.8 8080.2 8089.4 6565.4 6605.9 6619.4 6650.1 6776.6 7103.5 7322.1 7327.7 7333.7 7358.3 6802.7 6842.1 6928.5 6939.6 6953.2 6495.1 6578.8 6631.5 6691.4 6741.7 6625.0 6635.8 6657.4 6658.7 6660.5 5974.3 6066.7 6090.5 6101.2 6123.9 6216.1 6219.5 6287.9 6288.2 6304.2 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#4] prototype.html Cycles:180 Average:5545.14 Median:6298.12 stddev:1704.49 (27.1%) stddev-sans-first:1663.89 10:08:47 INFO - PROCESS | 11094 | Values: 339.3 346.0 350.4 352.6 356.5 6232.6 6251.3 6261.3 6319.0 6366.0 6194.7 6216.8 6230.6 6251.8 6257.0 4720.0 4725.8 4728.7 4731.8 4733.3 4724.1 4727.5 4732.3 4737.6 4738.0 4548.4 4608.2 4614.7 4622.9 4689.0 4667.8 4674.1 4689.0 4690.2 4696.3 4043.0 4049.8 4050.0 4056.5 4060.2 5909.3 5920.1 5927.3 5938.4 5948.8 5261.7 5391.9 5431.0 5438.1 5444.5 6588.1 6589.2 6591.9 6602.8 6613.1 4486.3 4490.9 4497.5 4498.7 4499.8 6794.5 6862.3 6922.3 6928.8 6929.9 4643.1 4655.0 4662.9 4674.0 4683.4 4730.4 4732.8 4734.0 4736.1 4749.4 5470.1 5475.0 5480.3 5492.5 5496.3 6452.3 6627.6 6651.0 6656.9 6664.9 1651.8 1669.4 1673.1 1677.8 1678.7 1037.8 1053.7 1086.2 1088.2 1090.7 6286.9 6300.8 6315.3 6319.9 6330.4 6825.3 6850.5 6851.4 6860.1 6869.7 6189.7 6295.4 6311.8 6321.6 6322.1 3701.7 3716.3 3747.6 3758.8 3762.4 7222.5 7232.2 7236.8 7247.1 7259.3 6977.7 7103.0 7112.9 7118.1 7129.6 7195.0 7235.0 7238.4 7252.8 7252.9 6817.8 6875.3 6875.7 6875.8 6885.2 6719.4 6802.1 6839.4 6848.6 6849.7 7193.5 7204.0 7226.5 7228.1 7233.1 4640.2 4665.3 4665.9 4678.0 4684.9 6796.2 6806.5 6932.9 6937.0 6946.2 6685.5 6693.5 6708.4 6710.7 6732.6 6548.7 6686.2 6711.3 6713.9 6717.2 6529.8 6531.3 6542.7 6546.1 6546.9 6758.3 6759.8 6761.9 6763.9 6771.0 6375.4 6528.3 6583.4 6585.0 6586.9 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - PROCESS | 11094 | [#5] yui.html Cycles:180 Average:13499.14 Median:4327.27 stddev:15468.23 (357.5%) stddev-sans-first:15482.36 10:08:47 INFO - PROCESS | 11094 | Values: 830.6 840.6 843.5 845.5 866.8 12577.0 12728.6 12850.7 12858.3 12892.0 11992.0 12052.2 13357.4 13538.9 13582.9 789.9 795.9 800.1 800.7 801.3 804.2 810.2 810.6 811.5 811.6 847.9 853.6 853.8 854.2 858.3 841.1 845.6 847.4 849.7 849.9 614.2 618.4 620.0 620.3 623.0 13546.4 13547.3 13588.3 13717.2 13757.4 12393.6 12454.4 12543.5 12887.4 12897.5 9956.9 10226.0 10525.4 10621.4 10668.7 3588.9 3624.5 3691.9 3740.2 3780.1 42198.0 42441.0 42775.1 42862.1 46629.6 9759.2 9864.6 9947.3 9991.2 10036.5 16445.4 16620.7 16677.7 16694.5 16734.2 7477.1 7489.9 7614.0 7683.3 7900.2 4307.4 4309.6 4344.9 4424.8 4428.7 2982.9 2984.0 2994.1 3009.6 3014.5 520.6 537.0 542.9 551.0 551.2 616.0 651.9 660.5 679.0 684.1 7771.4 7774.1 7947.4 7996.0 8362.9 582.6 618.1 654.7 666.4 671.7 3641.6 3961.4 3989.4 4007.0 4070.8 57722.7 59700.7 59791.7 59920.7 59975.0 45340.8 46084.3 46500.5 50042.2 50505.7 46867.0 47615.8 47839.0 48833.5 49024.8 8213.2 8613.9 8636.3 8758.9 8770.5 33430.0 33757.8 34029.8 34097.8 34353.5 40111.4 40250.4 40265.6 41873.6 42618.0 11226.7 11688.6 11719.8 11860.0 12498.6 10908.3 11403.6 11713.7 12216.5 12445.1 11465.3 11486.1 11674.4 11875.7 12231.8 10869.8 10928.8 11001.6 11407.4 11671.2 11204.8 11254.8 11255.0 11379.6 11714.6 9963.7 10287.2 10330.6 10336.4 10757.8 9256.7 9425.6 9560.6 9721.4 10159.0 10:08:47 INFO - PROCESS | 11094 | -------- Summary: end -------- 10:08:47 INFO - PROCESS | 11094 | 10:08:47 INFO - TEST-INFO | 11094: exit 0 10:08:47 INFO - TEST-OK | dromaeo_css | took 1110330ms 10:08:47 INFO - TEST-START | kraken 10:08:47 INFO - operating with platform_type : linux_ 10:08:47 INFO - Initialising browser for kraken test... 10:08:47 INFO - TEST-INFO | started process 11335 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ4A4UM/profile http://localhost:38258/getInfo.html) 10:08:52 INFO - PROCESS | 11335 | __metrics Screen width/height:1600/1200 10:08:52 INFO - PROCESS | 11335 | colorDepth:24 10:08:52 INFO - PROCESS | 11335 | Browser inner width/height: 1024/697 10:08:52 INFO - PROCESS | 11335 | __metrics 10:08:52 INFO - PROCESS | 11335 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:08:53 INFO - TEST-INFO | 11335: exit 0 10:08:53 INFO - Browser initialized. 10:08:53 INFO - Running cycle 1/1 for kraken test... 10:08:53 INFO - TEST-INFO | started process 11457 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ4A4UM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:05 INFO - PROCESS | 11457 | RSS: Main: 150306816 10:09:05 INFO - PROCESS | 11457 | 10:09:07 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38258/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:08 INFO - PROCESS | 11457 | RSS: Main: 151003136 10:09:08 INFO - PROCESS | 11457 | 10:09:11 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38258/tests/kraken/driver.html?testName=audio-dft) 10:09:11 INFO - PROCESS | 11457 | RSS: Main: 152145920 10:09:11 INFO - PROCESS | 11457 | 10:09:14 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38258/tests/kraken/driver.html?testName=audio-fft) 10:09:15 INFO - PROCESS | 11457 | RSS: Main: 145625088 10:09:15 INFO - PROCESS | 11457 | 10:09:17 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38258/tests/kraken/driver.html?testName=audio-oscillator) 10:09:17 INFO - PROCESS | 11457 | RSS: Main: 146632704 10:09:17 INFO - PROCESS | 11457 | 10:09:20 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38258/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:20 INFO - PROCESS | 11457 | RSS: Main: 146939904 10:09:20 INFO - PROCESS | 11457 | 10:09:23 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38258/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:24 INFO - PROCESS | 11457 | RSS: Main: 147894272 10:09:24 INFO - PROCESS | 11457 | 10:09:27 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38258/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:28 INFO - PROCESS | 11457 | RSS: Main: 149151744 10:09:28 INFO - PROCESS | 11457 | 10:09:31 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38258/tests/kraken/driver.html?testName=json-parse-financial) 10:09:31 INFO - PROCESS | 11457 | RSS: Main: 149110784 10:09:31 INFO - PROCESS | 11457 | 10:09:33 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38258/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:33 INFO - PROCESS | 11457 | RSS: Main: 147247104 10:09:33 INFO - PROCESS | 11457 | 10:09:35 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:36 INFO - PROCESS | 11457 | RSS: Main: 147963904 10:09:36 INFO - PROCESS | 11457 | 10:09:38 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:39 INFO - PROCESS | 11457 | RSS: Main: 149262336 10:09:39 INFO - PROCESS | 11457 | 10:09:41 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:42 INFO - PROCESS | 11457 | RSS: Main: 148770816 10:09:42 INFO - PROCESS | 11457 | 10:09:44 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:45 INFO - PROCESS | 11457 | RSS: Main: 148717568 10:09:45 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | Cycle 1(1): loaded http://localhost:38258/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38258/tests/kraken/driver.html?testName=ai-astar) 10:09:47 INFO - PROCESS | 11457 | RSS: Main: 149626880 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | __start_tp_report 10:09:47 INFO - PROCESS | 11457 | _x_x_mozilla_page_load 10:09:47 INFO - PROCESS | 11457 | _x_x_mozilla_page_load_details 10:09:47 INFO - PROCESS | 11457 | |i|pagename|runs| 10:09:47 INFO - PROCESS | 11457 | |0;ai-astar;112;105;111;109;111;122;110;109;111;110 10:09:47 INFO - PROCESS | 11457 | |1;audio-beat-detection;158;131;150;168;125;155;154;127;163;125 10:09:47 INFO - PROCESS | 11457 | |2;audio-dft;162;163;162;161;163;162;164;167;170;165 10:09:47 INFO - PROCESS | 11457 | |3;audio-fft;71;73;71;72;71;142;72;74;72;72 10:09:47 INFO - PROCESS | 11457 | |4;audio-oscillator;96;96;135;96;97;96;144;98;96;140 10:09:47 INFO - PROCESS | 11457 | |5;imaging-gaussian-blur;110;110;110;109;110;109;109;110;110;109 10:09:47 INFO - PROCESS | 11457 | |6;imaging-darkroom;147;147;147;146;147;147;148;148;147;147 10:09:47 INFO - PROCESS | 11457 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;97;96 10:09:47 INFO - PROCESS | 11457 | |8;json-parse-financial;61;62;62;61;61;60;61;61;59;62 10:09:47 INFO - PROCESS | 11457 | |9;json-stringify-tinderbox;67;71;66;67;68;69;67;68;68;68 10:09:47 INFO - PROCESS | 11457 | |10;stanford-crypto-aes;86;86;88;85;93;85;88;85;86;85 10:09:47 INFO - PROCESS | 11457 | |11;stanford-crypto-ccm;128;120;120;138;124;126;126;120;119;120 10:09:47 INFO - PROCESS | 11457 | |12;stanford-crypto-pbkdf2;144;156;152;152;149;163;153;150;164;141 10:09:47 INFO - PROCESS | 11457 | |13;stanford-crypto-sha256-iterative;70;70;69;70;68;70;67;89;69;67 10:09:47 INFO - PROCESS | 11457 | __end_tp_report 10:09:47 INFO - PROCESS | 11457 | __start_cc_report 10:09:47 INFO - PROCESS | 11457 | _x_x_mozilla_cycle_collect,735 10:09:47 INFO - PROCESS | 11457 | __end_cc_report 10:09:47 INFO - PROCESS | 11457 | __startTimestamp1451585387333__endTimestamp 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | ------- Summary: start ------- 10:09:47 INFO - PROCESS | 11457 | Number of tests: 14 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.57 10:09:47 INFO - PROCESS | 11457 | Values: 112.0 105.0 111.0 109.0 111.0 122.0 110.0 109.0 111.0 110.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:154.50 stddev:16.81 (10.9%) stddev-sans-first:17.22 10:09:47 INFO - PROCESS | 11457 | Values: 158.0 131.0 150.0 168.0 125.0 155.0 154.0 127.0 163.0 125.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.77 (1.7%) stddev-sans-first:2.85 10:09:47 INFO - PROCESS | 11457 | Values: 162.0 163.0 162.0 161.0 163.0 162.0 164.0 167.0 170.0 165.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.00 stddev:22.16 (30.8%) stddev-sans-first:23.31 10:09:47 INFO - PROCESS | 11457 | Values: 71.0 73.0 71.0 72.0 71.0 142.0 72.0 74.0 72.0 72.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.00 (21.9%) stddev-sans-first:21.71 10:09:47 INFO - PROCESS | 11457 | Values: 96.0 96.0 135.0 96.0 97.0 96.0 144.0 98.0 96.0 140.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:09:47 INFO - PROCESS | 11457 | Values: 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:09:47 INFO - PROCESS | 11457 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 148.0 148.0 147.0 147.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:09:47 INFO - PROCESS | 11457 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:61.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 10:09:47 INFO - PROCESS | 11457 | Values: 61.0 62.0 62.0 61.0 61.0 60.0 61.0 61.0 59.0 62.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 10:09:47 INFO - PROCESS | 11457 | Values: 67.0 71.0 66.0 67.0 68.0 69.0 67.0 68.0 68.0 68.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.00 stddev:2.50 (2.9%) stddev-sans-first:2.64 10:09:47 INFO - PROCESS | 11457 | Values: 86.0 86.0 88.0 85.0 93.0 85.0 88.0 85.0 86.0 85.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.00 stddev:5.86 (4.7%) stddev-sans-first:6.04 10:09:47 INFO - PROCESS | 11457 | Values: 128.0 120.0 120.0 138.0 124.0 126.0 126.0 120.0 119.0 120.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.50 stddev:7.29 (4.8%) stddev-sans-first:7.07 10:09:47 INFO - PROCESS | 11457 | Values: 144.0 156.0 152.0 152.0 149.0 163.0 153.0 150.0 164.0 141.0 10:09:47 INFO - PROCESS | 11457 | 10:09:47 INFO - PROCESS | 11457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.00 stddev:6.47 (9.2%) stddev-sans-first:6.86 10:09:47 INFO - PROCESS | 11457 | Values: 70.0 70.0 69.0 70.0 68.0 70.0 67.0 89.0 69.0 67.0 10:09:47 INFO - PROCESS | 11457 | -------- Summary: end -------- 10:09:47 INFO - PROCESS | 11457 | 10:09:48 INFO - TEST-INFO | 11457: exit 0 10:09:48 INFO - TEST-OK | kraken | took 60345ms 10:09:48 INFO - TEST-START | v8_7 10:09:48 INFO - operating with platform_type : linux_ 10:09:48 INFO - Initialising browser for v8_7 test... 10:09:48 INFO - TEST-INFO | started process 11745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Rj1ko/profile http://localhost:38258/getInfo.html) 10:09:52 INFO - PROCESS | 11745 | __metrics Screen width/height:1600/1200 10:09:52 INFO - PROCESS | 11745 | colorDepth:24 10:09:52 INFO - PROCESS | 11745 | Browser inner width/height: 1024/697 10:09:52 INFO - PROCESS | 11745 | __metrics 10:09:53 INFO - PROCESS | 11745 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:09:53 INFO - TEST-INFO | 11745: exit 0 10:09:53 INFO - Browser initialized. 10:09:53 INFO - Running cycle 1/1 for v8_7 test... 10:09:53 INFO - TEST-INFO | started process 11868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Rj1ko/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:05 INFO - PROCESS | 11868 | RSS: Main: 150515712 10:10:05 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | Cycle 1(1): loaded http://localhost:38258/tests/v8_7/run.html (next: http://localhost:38258/tests/v8_7/run.html) 10:10:27 INFO - PROCESS | 11868 | RSS: Main: 146522112 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | __start_tp_report 10:10:27 INFO - PROCESS | 11868 | _x_x_mozilla_page_load 10:10:27 INFO - PROCESS | 11868 | _x_x_mozilla_page_load_details 10:10:27 INFO - PROCESS | 11868 | |i|pagename|runs| 10:10:27 INFO - PROCESS | 11868 | |0;Richards;167.36401673640168 10:10:27 INFO - PROCESS | 11868 | |1;DeltaBlue;189.000189000189 10:10:27 INFO - PROCESS | 11868 | |2;Encrypt;279.17364600781684 10:10:27 INFO - PROCESS | 11868 | |3;Decrypt;5208.333333333333 10:10:27 INFO - PROCESS | 11868 | |4;RayTrace;1054.8523206751054 10:10:27 INFO - PROCESS | 11868 | |5;Earley;706.2146892655368 10:10:27 INFO - PROCESS | 11868 | |6;Boyer;12243.90243902439 10:10:27 INFO - PROCESS | 11868 | |7;RegExp;25923.076923076922 10:10:27 INFO - PROCESS | 11868 | |8;Splay;659.6306068601583 10:10:27 INFO - PROCESS | 11868 | |9;NavierStokes;4830.917874396136 10:10:27 INFO - PROCESS | 11868 | __end_tp_report 10:10:27 INFO - PROCESS | 11868 | __startTimestamp1451585427402__endTimestamp 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | ------- Summary: start ------- 10:10:27 INFO - PROCESS | 11868 | Number of tests: 10 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 167.4 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 189.0 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 279.2 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 5208.3 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#4] RayTrace Cycles:1 Average:1054.85 Median:1054.85 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 1054.9 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 706.2 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 12243.9 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 25923.1 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#8] Splay Cycles:1 Average:659.63 Median:659.63 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 659.6 10:10:27 INFO - PROCESS | 11868 | 10:10:27 INFO - PROCESS | 11868 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:10:27 INFO - PROCESS | 11868 | Values: 4830.9 10:10:27 INFO - PROCESS | 11868 | -------- Summary: end -------- 10:10:27 INFO - PROCESS | 11868 | 10:10:28 INFO - TEST-INFO | 11868: exit 0 10:10:28 INFO - TEST-OK | v8_7 | took 39984ms 10:10:28 INFO - SUITE-END | took 1210s 10:10:28 INFO - Completed test suite (00:20:10) 10:10:28 INFO - Working with test: dromaeo_css 10:10:28 INFO - Generating results file: dromaeo_css 10:10:28 INFO - Working with test: kraken 10:10:28 INFO - Generating results file: kraken 10:10:28 INFO - javascript benchmark 10:10:28 INFO - Working with test: v8_7 10:10:28 INFO - Generating results file: v8_7 10:10:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 10:10:28 INFO - process_Request line: dromaeo_css 6992.70 graph.html#tests=[[72,63,43]] 10:10:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:28 INFO - process_Request line: kraken 1524.80 graph.html#tests=[[232,63,43]] 10:10:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:28 INFO - process_Request line: v8_7 21160.77 graph.html#tests=[[230,63,43]] 10:10:28 INFO - RETURN: dromaeo_css: 6992.70 10:10:28 INFO - RETURN: kraken: 1524.80 10:10:28 INFO - RETURN: v8_7: 21160.77 10:10:28 INFO - javascript benchmark 10:10:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3168.889088881889, 3198.5681932939046, 3223.9032829015136, 3228.4188846007723, 3236.9190770230744, 5108.540231379176, 5109.693418394894, 5121.718305493197, 5124.897502049961, 5206.245094461301, 5208.973955130219, 5264.447233040523, 5276.393214780302, 5276.472352764722, 5279.234510995903, 4853.029394121181, 4856.441509226449, 4894.119058569456, 4915.655904086715, 4933.260010998343, 4878.146324393235, 4889.242167464049, 4898.28974798654, 4900.950990490103, 4907.411110666725, 4523.8642840714665, 4689.132510485554, 4828.396450443694, 4840.1771698810935, 4852.393450818648, 4818.59041981432, 4843.757812109416, 4863.10032643962, 4877.756112194412, 4883.12103821312, 4722.079194557063, 4824.179889418807, 4829.975850120762, 4833.951660483385, 4897.191963326047, 5061.746912654353, 5062.67092638981, 5094.974525127351, 5103.336566246364, 5164.793408263665, 5487.42382049887, 5573.916391254134, 5575.581831362664, 5580.107182850765, 5608.270924779793, 5597.944020559783, 5632.859178520529, 5647.209390685307, 5686.459786320293, 5769.624974376652, 5366.570674346043, 5381.0583147948955, 5382.91925621116, 5384.353877534721, 5403.081476149064, 5890.705464726832, 5895.587308888336, 5895.764169433261, 5897.115432685046, 5902.881942361215, 5392.379876314196, 5494.066008778517, 5508.779648814003, 5616.943830561724, 5656.406077361818, 5666.744996475169, 5683.715814209273, 5685.289338832646, 5698.458646428583, 5713.628614140068, 5519.586031047687, 5564.998300305984, 5606.943930560724, 5609.270794796732, 5614.887702245932, 5547.583931205176, 5565.02612042899, 5571.582131340166, 5664.8867022659315, 5693.459121383462, 4193.39195816611, 4206.242876282298, 4209.2633789086785, 4217.987682956068, 4248.362745588187, 3791.639794219545, 3805.238952209569, 3806.847726090981, 3809.5619003814363, 3829.4064420014943, 5270.025045366619, 5274.208868669731, 5315.973420132875, 5333.413324534298, 5380.542653874464, 5630.690312032795, 5664.405237450091, 5670.631408958405, 5686.061799803069, 5687.431256874363, 5187.4553171916405, 5316.73416329182, 5318.0, 5324.494173053554, 5386.865328366822, 4630.976845115752, 4720.362751028636, 4785.306130611042, 4813.4945830687975, 4829.5653391194965, 5925.644461332334, 5926.940730592725, 5944.375840536768, 5945.583809133405, 5947.881042379215, 5585.944140558705, 5709.600327977002, 5722.685252311163, 5737.139429085671, 5797.565182611237, 5843.065109582446, 5954.970225148846, 5956.940430595639, 5965.28416590012, 5980.790672326448, 5674.886502269849, 5712.11462223356, 5713.22871412354, 5715.171300161536, 5726.141078838207, 5507.889842203053, 5604.439556044526, 5635.774569017193, 5714.885702285847, 5805.796797112081, 5649.774009039593, 5656.264685590847, 5659.349174844946, 5666.744996475086, 5672.290963629546, 5618.522425593706, 5627.803026894039, 5636.971815140898, 5640.689762063126, 5644.6613203207935, 5351.5183633471615, 5474.8905021898545, 5482.150266708666, 5493.450654934474, 5496.7526461308535, 5466.316710411199, 5565.944340556704, 5626.915596266142, 5642.040853054908, 5673.602847800615, 5346.037713211659, 5358.4105748366865, 5371.060064488777, 5371.516563509146, 5385.676859388449], "unit": "score", "name": "dojo.html", "value": 5219.888881505214}, {"lowerIsBetter": false, "replicates": [532.3558494221991, 566.9262995810546, 574.0241589298195, 592.4786188154424, 607.5018484842428, 34418.0, 34822.78120265788, 34873.0, 35115.473267901005, 35120.47319290213, 35487.11282217939, 35765.642343576554, 36133.638663613354, 36182.276354472895, 36249.63750362496, 8205.22050405212, 8300.418970672055, 8371.372147088961, 8372.079071302152, 8409.0, 8104.149064348247, 8181.263686268235, 8189.181081891793, 8234.341252699769, 8261.545614991173, 8223.383246256524, 8345.83308333833, 8357.707480238192, 8369.748907532754, 8371.330293576499, 8338.790875323075, 8404.537750423724, 8408.663653453854, 8421.115782842806, 8461.53461559614, 8255.545944973024, 8327.875081873777, 8335.54154521501, 8423.915760842374, 8468.618912148968, 35939.64060359389, 35965.0, 36144.63855361439, 36390.27219455596, 36392.0, 3158.1788734928855, 3189.4953039941106, 3268.0686004488607, 3424.9486257706153, 3495.4756786481976, 28710.282242943886, 28845.711542884514, 29021.709782902322, 29313.413731725246, 29542.113736587937, 3955.960440395588, 3956.742811717229, 3983.40248962655, 4010.7593544387137, 4065.3495440729343, 248143.0, 248631.0, 248787.0, 248894.0, 249689.0, 57133.14300285499, 57686.0, 57721.42278577245, 57881.13178302329, 57912.42087579155, 65099.67450162719, 65760.34239657638, 65876.6706166466, 65909.0, 66121.0, 14739.55781326562, 14943.701125977419, 14952.327145278488, 14958.401663933539, 14966.32651530662, 11960.342181180118, 11981.28112313264, 12073.396330183456, 12083.39583020863, 12095.032397408362, 19757.209711611664, 20139.49651258701, 20289.898550507154, 20374.083166257555, 20378.286759963627, 7819.218078192135, 7829.29536341732, 7942.404319676048, 8048.315893149031, 8078.959605202054, 910.3263584947091, 917.1287277086794, 1040.2250323508883, 1042.7966546523508, 1063.8297872340543, 28576.285592860346, 29089.563656545168, 30133.397332053235, 31069.378612427627, 33112.3377532448, 1031.4997226345217, 1053.3627155570923, 1067.3489171605315, 1086.2450596835124, 1097.5225776787124, 14857.554273371816, 14907.627309317137, 14931.402743890123, 15101.169435680924, 15136.848631513763, 359372.0, 363431.0, 363887.0, 364329.0, 364716.0, 52458.475415246125, 52979.470205298225, 52992.73503632457, 53043.20435193475, 53072.46927530675, 1313.947442102305, 1348.2449828096298, 1363.3115276785359, 1364.7270545890863, 1368.8699573540498, 28303.71696283093, 28597.28506787347, 29010.709892900803, 29016.65233992303, 29105.85447072751, 45157.77421112874, 45598.0, 45829.31256031229, 45861.541384585726, 46051.53948460473, 291640.0, 293972.0, 296871.0, 296912.0, 297068.0, 27179.72820271772, 28145.0, 30553.388932221675, 31671.366572667957, 32359.51460728044, 36050.4592431119, 36241.46981627297, 36574.634253657125, 36986.26027479489, 37041.62958370382, 31207.687923120477, 31717.841410792797, 33874.49188262129, 34593.30813383769, 34838.47742283817, 33856.49215261724, 34466.0, 34705.65294347024, 34774.0, 34788.82605586956, 33993.0, 37420.43869342017, 38380.616193837704, 38671.41992870165, 38700.22599547937, 28107.718922811328, 30462.238444039078, 33894.3221135571, 34955.0, 35460.29079418449, 24502.26493205207, 24921.376965576004, 25532.61701074448, 25738.0, 25811.741882581686], "unit": "score", "name": "ext.html", "value": 18146.433244039352}, {"lowerIsBetter": false, "replicates": [364.3841907176871, 369.77074213987333, 370.6071564142009, 373.19203923505614, 373.43984023964055, 11585.6524304271, 11984.520619175222, 16137.677246455078, 16922.74615880761, 17594.208260628286, 17271.481855544323, 17326.220320085595, 17350.219240134193, 17478.563035924075, 17534.649307013853, 6061.878762424749, 6197.349278325779, 6226.533010024266, 6231.127642130083, 6239.157713708637, 5638.830835074934, 5818.621789583684, 6072.908906366408, 6108.419700128503, 6163.291221509517, 6073.665948372838, 6146.231721034871, 6186.133941248207, 6206.565540412173, 6428.067930150125, 6270.153529273581, 6297.968510157443, 6344.999999999977, 6352.078948552457, 6447.194100737408, 6428.485721142298, 6444.709988050549, 6459.450946669539, 6466.708998095097, 6467.676616169219, 21361.35915922525, 22145.55708885813, 22318.665220021714, 22420.215292464847, 22986.195483158175, 2269.943251418711, 2293.334932869466, 2296.59809533331, 2343.4024323797494, 2485.3289611804894, 13830.585082447542, 14151.292435378293, 14431.783523247159, 14561.271936403138, 14668.633284167874, 1923.384516954575, 1974.6149500847341, 1990.7810140884492, 2013.5904866593296, 2045.4375046862083, 62541.0, 67236.66381668109, 67912.66043669799, 68723.0, 69107.0, 14801.111933284037, 15243.16162611067, 15253.313600887986, 15363.23183840826, 15387.307571159101, 23918.162864299666, 23957.963573096134, 23977.28068157958, 24121.396965076012, 24123.15568955113, 8895.688650897317, 8903.06517815633, 8942.150495702897, 8961.283097352196, 9183.862242066374, 7460.0, 7557.848843023219, 7559.357454616419, 7576.659050342748, 7593.278638529331, 7527.096748390229, 7627.923720762832, 7642.579658118746, 7646.082470103624, 7646.311831935152, 1820.8270214329618, 2973.435047340998, 2988.701129886994, 3035.6357237131688, 3088.7065728755733, 826.396730386821, 839.7816567692444, 862.9525376104249, 991.5884907763198, 1020.260311274335, 15808.92095539515, 15853.0, 15988.600284992735, 16031.919840400724, 16315.0, 933.290699068699, 934.4486752815872, 958.3722661656626, 963.9566219519999, 1022.7238645565656, 9159.313051521163, 9505.239580833517, 9619.230461563198, 10035.69892903214, 10112.797744045078, 423447.0, 451362.0, 493727.0, 496576.0, 499998.0, 70176.298237018, 70276.29723702697, 73550.63224683842, 73815.63092184505, 74694.25305746873, 478.2921276510784, 493.62977766674993, 493.98024079036435, 495.7719449053476, 496.34234639103335, 10174.389536627827, 10181.287309888534, 10282.794344113225, 10324.0, 10340.069393754296, 31412.0, 32292.515612265364, 33061.0, 33713.494297585064, 34718.30563388667, 41121.58878411297, 41154.1769164621, 41626.58373416348, 43768.0, 43913.0, 9307.860382094139, 9592.856107158259, 9691.757706057406, 9842.409455432697, 9849.704508864745, 16485.752713709542, 16740.916295418447, 16933.915330423762, 16954.0, 17419.82580174233, 13936.512222072179, 13981.650458738613, 14106.435742570593, 14204.147751134966, 14415.927920360751, 14213.360398782286, 14431.78352324695, 14828.184449855362, 14984.40062397492, 15135.318910649268, 14790.556283311518, 15124.0, 15244.847551524343, 15431.768523471932, 15541.37834486653, 9211.0, 9646.228301735984, 9971.05274998874, 9978.401295922267, 10051.547680354255, 10168.745781355525, 12364.1963272387, 14168.149911005372, 14398.0, 14419.85580144227], "unit": "score", "name": "jquery.html", "value": 9386.033246709683}, {"lowerIsBetter": false, "replicates": [1421.658801887547, 1433.2833583208392, 1553.533939818055, 1695.3557648093722, 1724.2585688154097, 7194.3165399287045, 7322.340989310967, 7324.926750732498, 7382.261773822615, 7480.0, 7415.962920185391, 7434.739784107557, 7436.1820199777985, 7476.738314159005, 7479.962600186991, 2183.8908054597246, 2206.6138425775507, 2226.365485836537, 2234.3743751749535, 2235.9217427390045, 2192.7697591752876, 2196.3850121965797, 2291.2438895164555, 2295.380247333219, 2298.195631528968, 2182.2907555044594, 2212.524307273936, 2226.9199438272426, 2228.4206106412366, 2238.9552208955893, 2221.566794475078, 2234.1398561553838, 2270.4664403865077, 2272.6363781795, 2274.1812947338944, 2184.6286131357706, 2196.560687862434, 2222.20000799712, 2241.8318626102946, 2245.7305123385136, 7293.52592081513, 7370.078740157481, 7374.410047196211, 7382.815429614249, 7384.889226661604, 4381.058072514393, 4440.689151759379, 4473.798679059418, 4484.506704262529, 4495.910081798378, 2894.131760471871, 3000.1749518882266, 3019.064090132044, 3032.36320372722, 3064.2798942248555, 946.7775072857942, 949.848024316113, 965.8454647256475, 987.0573602209872, 1005.1456262177164, 10197.694069177862, 10232.283740138193, 10239.078482936571, 10258.333208341508, 10259.974002599754, 3934.940975885364, 3954.940675889864, 3979.243943650697, 4015.819288132041, 4027.9798601006805, 8372.0, 8381.07808141104, 8395.412321137463, 8400.159984001551, 8431.451955622864, 4416.0, 4416.205083085011, 4426.800793964279, 4447.0, 4469.575390337913, 4100.384942258625, 4112.444819949328, 4123.8556650517085, 4124.752514849119, 4131.07050913548, 3265.8367081645824, 3270.2314955985325, 3279.0, 3282.983585082059, 3316.9336613268083, 987.6691308411619, 989.1098011789447, 990.8166989106894, 991.8809742830906, 996.2776986684596, 953.756792018031, 994.7363948553639, 1013.4578000769553, 1082.3614067700096, 1223.1804690857148, 6641.33586641332, 6659.234188068434, 6669.199696036507, 6670.833229169212, 6690.197176338773, 604.5194070713793, 615.8791000379356, 618.7617767159586, 645.3514218210669, 782.4210084537515, 5272.3076461948895, 5451.0, 5465.781368745285, 5470.53500452466, 5481.643693159932, 8671.869921951176, 8727.996280427706, 8898.288136949159, 8925.598348074222, 8974.28205743539, 8989.910100899038, 8990.86513702282, 9047.230985366317, 9058.094190581021, 9063.0, 7092.5389849659605, 7121.394681452031, 7153.3561979421065, 7174.677139528734, 7192.892106618405, 6736.831579210559, 6819.0794242778575, 6828.214755303204, 6839.179298484214, 6913.308669133046, 7628.80927976805, 7832.451728378959, 7843.450958432855, 7864.567448790372, 7907.0, 7841.764747057598, 7902.051753789352, 7963.800904977422, 8080.191980801873, 8089.352851771727, 6565.409113179837, 6605.933940660532, 6619.404253617197, 6650.102236198245, 6776.627285499345, 7103.467239957127, 7322.0847394075745, 7327.706891724271, 7333.6699848508015, 7358.264173582599, 6802.693878775368, 6842.076319696777, 6928.515003949675, 6939.618320992394, 6953.20038195614, 6495.123158373748, 6578.80263592093, 6631.469482441296, 6691.364320389555, 6741.73033078691, 6625.006249062679, 6635.8009259722285, 6657.367550082734, 6658.7336506539195, 6660.467162627075, 5974.342822289458, 6066.666333351708, 6090.451859332681, 6101.176341193882, 6123.938760612336, 6216.098665693539, 6219.533534984804, 6287.874242515216, 6288.151099601679, 6304.18045654062], "unit": "score", "name": "mootools.html", "value": 4215.849597609692}, {"lowerIsBetter": false, "replicates": [339.25533454068324, 345.9757816952813, 350.41305812763625, 352.59099444644215, 356.4528448831043, 6232.563720539564, 6251.281102673194, 6261.311255761868, 6318.9999999999945, 6366.045093236017, 6194.69026548673, 6216.751329946808, 6230.626162430257, 6251.843703907404, 6257.0, 4719.952800472003, 4725.787339569728, 4728.692634978724, 4731.763411829412, 4733.337332773414, 4724.102420540104, 4727.479977202505, 4732.290156476539, 4737.573618374346, 4738.0, 4548.363229147922, 4608.239640459337, 4614.700044497114, 4622.929250642895, 4688.953110468903, 4667.836625718118, 4674.111918735446, 4689.015306785579, 4690.179218636725, 4696.295555666643, 4043.0498832774274, 4049.8380064797375, 4049.959500405017, 4056.472658554369, 4060.20825938942, 5909.320428150775, 5920.111983202511, 5927.318358388798, 5938.376470470625, 5948.791792287249, 5261.657992230493, 5391.892162156774, 5431.049566325917, 5438.075527160392, 5444.482774136451, 6588.110605068302, 6589.242237142742, 6591.93408065918, 6602.8349291268105, 6613.107230523914, 4486.282194848841, 4490.932636010462, 4497.527759585229, 4498.730076195438, 4499.842505512292, 6794.45644348451, 6862.279460656609, 6922.342377474182, 6928.757493487754, 6929.896051559231, 4643.11780761661, 4654.953450465452, 4662.883427914261, 4673.976630116827, 4683.360823711673, 4730.408698912636, 4732.834350797774, 4734.0, 4736.1474934511425, 4749.430068391815, 5470.070088085035, 5474.972625136849, 5480.287562616834, 5492.47821456961, 5496.340439147248, 6452.257990331172, 6627.602343859384, 6650.9667451662435, 6656.900146497806, 6664.933350666432, 1651.7694317733126, 1669.3823285384242, 1673.1132499774894, 1677.8154403015658, 1678.7146185148554, 1037.7820657661825, 1053.6680945502142, 1086.1690806533009, 1088.2001728729379, 1090.7327704712395, 6286.9056964145575, 6300.810975670645, 6315.305316415191, 6319.905201421982, 6330.39861213184, 6825.283345248777, 6850.486213533905, 6851.38337549613, 6860.0738900248825, 6869.725210991504, 6189.721462534197, 6295.433410993032, 6311.842203944938, 6321.6207027577575, 6322.114903913456, 3701.685356744653, 3716.2939041582013, 3747.5502939647417, 3758.755680880734, 3762.398016317376, 7222.458315626244, 7232.240614735482, 7236.782896513113, 7247.094113235846, 7259.274072592699, 6977.686004129826, 7102.964485177645, 7112.92887071133, 7118.110236220473, 7129.572225666477, 7194.964025179841, 7235.0232718583375, 7238.420926325882, 7252.782416527512, 7252.948322493209, 6817.795466136024, 6875.312468753084, 6875.656217189221, 6875.759348422781, 6885.208201056943, 6719.428848547928, 6802.081718967876, 6839.384455399038, 6848.623325717133, 6849.691763870737, 7193.5324203926575, 7203.963980180066, 7226.494145409771, 7228.060352154186, 7233.132024157135, 4640.187967105676, 4665.323528088476, 4665.906681866411, 4677.953220467752, 4684.906301874012, 6796.18445786489, 6806.489513286622, 6932.896006560007, 6937.0, 6946.2011868635755, 6685.498587606046, 6693.531452798257, 6708.42978346846, 6710.698018589273, 6732.629705366252, 6548.705308261045, 6686.197656281277, 6711.261761206361, 6713.899291510729, 6717.16035495563, 6529.836754081186, 6531.281559028598, 6542.738290468518, 6546.116274302908, 6546.869062618816, 6758.256591774999, 6759.831004224934, 6761.898571521529, 6763.8985415219795, 6771.0, 6375.394337537927, 6528.314526974599, 6583.407493325432, 6585.045168450643, 6586.868262634816], "unit": "score", "name": "prototype.html", "value": 4987.457415413078}, {"lowerIsBetter": false, "replicates": [830.5639539241894, 840.6469282901182, 843.510763757021, 845.5476320168711, 866.7616405488494, 12577.0, 12728.554500592458, 12850.678733031667, 12858.292793896344, 12892.0, 11992.0, 12052.21660592063, 13357.398917048731, 13538.864611353883, 13582.93208533956, 789.8894154818315, 795.8607243732353, 800.1358532784578, 800.6957356204634, 801.2988634944423, 804.1837534902049, 810.2424233341815, 810.5866008335732, 811.4725428471481, 811.5860910935406, 847.8558645030329, 853.5945425922669, 853.7950891785989, 854.1543871567166, 858.3262139220712, 841.0622156295748, 845.6363763581658, 847.3856454070811, 849.6601359456236, 849.8980122385323, 614.241411856357, 618.3599974026905, 619.9969000155015, 620.2773768559667, 622.9657368844712, 13546.390412431465, 13547.322633868365, 13588.25264610446, 13717.245551494663, 13757.449702011907, 12393.62819115428, 12454.383877407756, 12543.498260069586, 12887.420066097047, 12897.548585799452, 9956.900430995742, 10226.0, 10525.36847789135, 10621.362718236931, 10668.733281668021, 3588.910277243064, 3624.5469316335457, 3691.9261614767825, 3740.1584643455276, 3780.0549862534367, 42197.999999999694, 42441.0, 42775.144497110196, 42862.142757145, 46629.601111966695, 9759.170470509944, 9864.556094975744, 9947.303688741864, 9991.150752186, 10036.498175091363, 16445.424410145828, 16620.6675866482, 16677.666446671, 16694.49916502507, 16734.16329183536, 7477.140128885248, 7489.887651685229, 7614.0, 7683.308502234826, 7900.249476299742, 4307.396964424983, 4309.612134907873, 4344.9348259776125, 4424.800883960165, 4428.6678499112695, 2982.8806847726282, 2984.015274959258, 2994.131701806495, 3009.5786589877434, 3014.487537118695, 520.6433592988815, 537.0306596593186, 542.9294191755047, 551.0219360634906, 551.2255281329739, 615.9568830181844, 651.90547370631, 660.4881217056724, 678.9679686876019, 684.1414025398193, 7771.417143714244, 7774.144844067148, 7947.3642108631175, 7995.960020199862, 8362.89154218909, 582.5834528312278, 618.1099217127412, 654.7381047581006, 666.4468491152332, 671.7111641993891, 3641.599424063351, 3961.3661814109605, 3989.3617021276455, 4006.982543640898, 4070.816813243411, 57722.71138644364, 59700.70149649224, 59791.70104149451, 59920.70039649861, 59975.0, 45340.77329613331, 46084.308735369, 46500.5349946503, 50042.24936625954, 50505.74747126241, 46867.0, 47615.76192119087, 47839.0, 48833.511664883605, 49024.754876225394, 8213.219744124299, 8613.913860861561, 8636.265917397091, 8758.868616970878, 8770.517621530877, 33430.0, 33757.83121084379, 34029.82985085059, 34097.82951085229, 34353.48469772905, 40111.3983290245, 40250.396244056945, 40265.59734402619, 41873.58126418697, 42618.0, 11226.663200103683, 11688.590899318484, 11719.824202637137, 11860.0, 12498.562550310695, 10908.34549927007, 11403.600873969372, 11713.707157321136, 12216.511339546318, 12445.128840981044, 11465.31208127515, 11486.13853960973, 11674.416279186176, 11875.703107422383, 12231.816522752344, 10869.782604348027, 10928.836067458835, 11001.559937602406, 11407.372594507382, 11671.183017188716, 11204.775904481701, 11254.774904502028, 11255.0, 11379.601713939972, 11714.589989350332, 9963.651272205438, 10287.177025838064, 10330.638427654996, 10336.431496267778, 10757.784844303227, 9256.72229833106, 9425.62297508092, 9560.61757529691, 9721.368111072758, 10159.0], "unit": "score", "name": "yui.html", "value": 6253.602486696327}], "name": "dromaeo_css", "value": 6992.700304121334}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 109.0, 111.0, 122.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 150.0, 168.0, 125.0, 155.0, 154.0, 127.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 162.0, 164.0, 167.0, 170.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 72.0, 71.0, 142.0, 72.0, 74.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 135.0, 96.0, 97.0, 96.0, 144.0, 98.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0, 59.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 66.0, 67.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 85.0, 93.0, 85.0, 88.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 120.0, 138.0, 124.0, 126.0, 126.0, 120.0, 119.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [144.0, 156.0, 152.0, 152.0, 149.0, 163.0, 153.0, 150.0, 164.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 69.0, 70.0, 68.0, 70.0, 67.0, 89.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1524.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1054.8523206751054], "unit": "score", "name": "RayTrace", "value": 701.5095719999998}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [659.6306068601583], "unit": "score", "name": "Splay", "value": 123.54035599999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21160.77301568804}]} 10:10:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21160.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1524.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6992.70"}}} 10:10:28 INFO - Return code: 0 10:10:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:10:28 INFO - # TBPL SUCCESS # 10:10:28 INFO - Running post-action listener: _resource_record_post_action 10:10:28 INFO - Running post-run listener: _resource_record_post_run 10:10:30 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560349184; Read time: 12; Write time: 568548 10:10:30 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241508352; Read time: 0; Write time: 297856 10:10:30 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317964288; Read time: 12; Write time: 270652 10:10:30 INFO - Running post-run listener: _upload_blobber_files 10:10:30 INFO - Blob upload gear active. 10:10:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:10:30 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 10:10:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:10:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:10:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:10:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:31 INFO - (blobuploader) - INFO - Done attempting. 10:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:10:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:32 INFO - (blobuploader) - INFO - Done attempting. 10:10:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:32 INFO - Return code: 0 10:10:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:10:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ece898da566fe8f104c4a4209a27615c09d3bc6d5fc8222688affc17f295b601ff09167f72e50b93fb86dce716701ba38bbd0272949d1f68aae5c3ffb11c85d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecccb5d442f93e0ba554b086326d61ddc32fbed3e3945e53ea74ecf3bec8d52e9d059acbaa53e948580818be8484427b1bbe704d2b4f9d9ecbbe41b0f45b2672"} 10:10:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:10:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:10:32 INFO - Contents: 10:10:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ece898da566fe8f104c4a4209a27615c09d3bc6d5fc8222688affc17f295b601ff09167f72e50b93fb86dce716701ba38bbd0272949d1f68aae5c3ffb11c85d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecccb5d442f93e0ba554b086326d61ddc32fbed3e3945e53ea74ecf3bec8d52e9d059acbaa53e948580818be8484427b1bbe704d2b4f9d9ecbbe41b0f45b2672"} 10:10:32 INFO - Copying logs to upload dir... 10:10:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.016778 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-31 10:10:31.870530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 10:10:31.874425) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ece898da566fe8f104c4a4209a27615c09d3bc6d5fc8222688affc17f295b601ff09167f72e50b93fb86dce716701ba38bbd0272949d1f68aae5c3ffb11c85d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecccb5d442f93e0ba554b086326d61ddc32fbed3e3945e53ea74ecf3bec8d52e9d059acbaa53e948580818be8484427b1bbe704d2b4f9d9ecbbe41b0f45b2672"} build_url:https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/GJrgE1MGSvSRIgpoHSsiNQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ece898da566fe8f104c4a4209a27615c09d3bc6d5fc8222688affc17f295b601ff09167f72e50b93fb86dce716701ba38bbd0272949d1f68aae5c3ffb11c85d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ecccb5d442f93e0ba554b086326d61ddc32fbed3e3945e53ea74ecf3bec8d52e9d059acbaa53e948580818be8484427b1bbe704d2b4f9d9ecbbe41b0f45b2672"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 10:10:31.899812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:10:31.900185) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451582274.945501-1501523722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 10:10:31.984349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 10:10:31.984816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 10:10:31.985337) ========= ========= Total master_lag: 0.30 =========