builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1451344884.51 results: success (0) buildid: 20151228113006 builduid: 5435a8b5d3f64845a71e4ab2812de54a revision: 7ce13695874558e5a60fc8d4758553d7913e43dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.513403) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.514031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.514362) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006498 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.582283) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.582618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.686309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.686609) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.749108) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.749411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.749800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.750131) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 15:21:24-- 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% 218M=0s 2015-12-28 15:21:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204688 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.972883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:24.973212) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.023002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.023366) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7ce13695874558e5a60fc8d4758553d7913e43dd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7ce13695874558e5a60fc8d4758553d7913e43dd --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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 15:21:25,319 truncating revision to first 12 chars 2015-12-28 15:21:25,319 Setting DEBUG logging. 2015-12-28 15:21:25,319 attempt 1/10 2015-12-28 15:21:25,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7ce136958745?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 15:21:25,681 unpacking tar archive at: b2g-inbound-7ce136958745/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.714279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.714777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.725635) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.726006) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 15:21:25.726513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-28 15:21:25.726834) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:26 INFO - MultiFileLogger online at 20151228 15:21:26 in /builds/slave/test-pgo 15:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 15:21:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:21:26 INFO - {'append_to_log': False, 15:21:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:21:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 15:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:21:26 INFO - 'branch': 'B2G-Inbound', 15:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:26 INFO - 'config_files': ('talos/linux_config.py',), 15:21:26 INFO - 'default_actions': ('clobber', 15:21:26 INFO - 'read-buildbot-config', 15:21:26 INFO - 'download-and-extract', 15:21:26 INFO - 'populate-webroot', 15:21:26 INFO - 'create-virtualenv', 15:21:26 INFO - 'install', 15:21:26 INFO - 'run-tests'), 15:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:26 INFO - 'download_minidump_stackwalk': True, 15:21:26 INFO - 'download_symbols': 'ondemand', 15:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:26 INFO - 'installer_path': 'installer.exe', 15:21:26 INFO - 'log_level': 'info', 15:21:26 INFO - 'log_name': 'talos', 15:21:26 INFO - 'log_to_console': True, 15:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:26 INFO - 'opt_config_files': (), 15:21:26 INFO - 'pip_index': False, 15:21:26 INFO - 'sps_profile': False, 15:21:26 INFO - 'sps_profile_interval': 0, 15:21:26 INFO - 'suite': 'dromaeojs', 15:21:26 INFO - 'system_bits': '32', 15:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:26 INFO - 'title': 'talos-linux64-ix-023', 15:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:26 INFO - 'use_talos_json': True, 15:21:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:26 INFO - 'work_dir': 'build'} 15:21:26 INFO - ##### 15:21:26 INFO - ##### Running clobber step. 15:21:26 INFO - ##### 15:21:26 INFO - Running pre-action listener: _resource_record_pre_action 15:21:26 INFO - Running main action method: clobber 15:21:26 INFO - rmtree: /builds/slave/test-pgo/build 15:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:21:26 INFO - Running post-action listener: _resource_record_post_action 15:21:26 INFO - ##### 15:21:26 INFO - ##### Running read-buildbot-config step. 15:21:26 INFO - ##### 15:21:26 INFO - Running pre-action listener: _resource_record_pre_action 15:21:26 INFO - Running main action method: read_buildbot_config 15:21:26 INFO - Using buildbot properties: 15:21:26 INFO - { 15:21:26 INFO - "project": "", 15:21:26 INFO - "product": "firefox", 15:21:26 INFO - "script_repo_revision": "production", 15:21:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 15:21:26 INFO - "repository": "", 15:21:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 15:21:26 INFO - "buildid": "20151228113006", 15:21:26 INFO - "pgo_build": "True", 15:21:26 INFO - "basedir": "/builds/slave/test-pgo", 15:21:26 INFO - "buildnumber": 1078, 15:21:26 INFO - "slavename": "talos-linux64-ix-023", 15:21:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:21:26 INFO - "platform": "ubuntu64_hw", 15:21:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 15:21:26 INFO - "branch": "b2g-inbound", 15:21:26 INFO - "repo_path": "integration/b2g-inbound", 15:21:26 INFO - "revision": "7ce13695874558e5a60fc8d4758553d7913e43dd", 15:21:26 INFO - "stage_platform": "linux64-pgo", 15:21:26 INFO - "builduid": "5435a8b5d3f64845a71e4ab2812de54a", 15:21:26 INFO - "slavebuilddir": "test" 15:21:26 INFO - } 15:21:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:21:26 INFO - Running post-action listener: _resource_record_post_action 15:21:26 INFO - ##### 15:21:26 INFO - ##### Running download-and-extract step. 15:21:26 INFO - ##### 15:21:26 INFO - Running pre-action listener: _resource_record_pre_action 15:21:26 INFO - Running main action method: download_and_extract 15:21:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:21: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')]} 15:21:26 INFO - https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/test_packages.json 15:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/test_packages.json 15:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:21:30 INFO - Downloaded 1302 bytes. 15:21:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:21:30 INFO - Using the following test package requirements: 15:21:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:21:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'jsshell-linux-x86_64.zip'], 15:21:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:21:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:21:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:21:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:21:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:21:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:21:30 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')]} 15:21:30 INFO - https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:21:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:31 INFO - Downloaded 23191498 bytes. 15:21:31 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 15:21:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:31 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 15:21:32 INFO - Return code: 0 15:21:32 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 15:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:32 INFO - https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:36 INFO - Downloaded 23191498 bytes. 15:21:36 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 15:21:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:21:36 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 15:21:38 INFO - Return code: 0 15:21:38 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')]} 15:21:38 INFO - https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:39 INFO - Downloaded 11132270 bytes. 15:21:39 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 15:21:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:39 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 15:21:39 INFO - Return code: 0 15:21: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')]} 15:21:39 INFO - https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/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 15:21:40 INFO - Downloaded 54892020 bytes. 15:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:21:40 INFO - mkdir: /builds/slave/test-pgo/properties 15:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:21:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:21:40 INFO - Contents: 15:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:21:40 INFO - Running post-action listener: _resource_record_post_action 15:21:40 INFO - Running post-action listener: set_extra_try_arguments 15:21:40 INFO - ##### 15:21:40 INFO - ##### Running populate-webroot step. 15:21:40 INFO - ##### 15:21:40 INFO - Running pre-action listener: _resource_record_pre_action 15:21:40 INFO - Running main action method: populate_webroot 15:21:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:21:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:21:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:21:40 INFO - '--tppagecycles', 15:21:40 INFO - '7'], 15:21:40 INFO - 'tests': ['tsvgm']}}, 15:21:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:21:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:21:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:21:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:21:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'tests': ['damp', 'tps']}, 15:21:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['damp', 'tps']}, 15:21:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:21:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:40 INFO - 'other': {'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'other_l64': {'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'other_nol64': {'tests': ['a11yr', 15:21:40 INFO - 'ts_paint', 15:21:40 INFO - 'tpaint', 15:21:40 INFO - 'sessionrestore', 15:21:40 INFO - 'sessionrestore_no_auto_restore']}, 15:21:40 INFO - 'svgr': {'tests': ['tsvgx', 15:21:40 INFO - 'tsvgr_opacity', 15:21:40 INFO - 'tart', 15:21:40 INFO - 'tscrollx', 15:21:40 INFO - 'cart']}, 15:21:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['tsvgx', 15:21:40 INFO - 'tsvgr_opacity', 15:21:40 INFO - 'tart', 15:21:40 INFO - 'tscrollx', 15:21:40 INFO - 'cart']}, 15:21:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'tests': ['tp5o']}, 15:21:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'talos_options': ['--e10s'], 15:21:40 INFO - 'tests': ['tp5o']}, 15:21:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'talos_options': ['--xperf_path', 15:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:40 INFO - 'tests': ['tp5n']}, 15:21:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:40 INFO - 'talos_options': ['--e10s', 15:21:40 INFO - '--xperf_path', 15:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:40 INFO - 'tests': ['tp5n']}}, 15:21:40 INFO - 'talos.zip': {'path': '', 15:21:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:21:40 INFO - Running post-action listener: _resource_record_post_action 15:21:40 INFO - ##### 15:21:40 INFO - ##### Running create-virtualenv step. 15:21:40 INFO - ##### 15:21:40 INFO - Running pre-action listener: _resource_record_pre_action 15:21:40 INFO - Running main action method: create_virtualenv 15:21:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:21:40 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 15:21:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:40 INFO - Using real prefix '/usr' 15:21:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:21:41 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:43 INFO - Installing pip.................done. 15:21:43 INFO - Return code: 0 15:21:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:21:43 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')]} 15:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:43 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')]} 15:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:43 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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:43 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 15:21:43 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 15:21:43 INFO - Using env: {'DISPLAY': ':0', 15:21:43 INFO - 'HOME': '/home/cltbld', 15:21:43 INFO - 'LANG': 'en_US.UTF-8', 15:21:43 INFO - 'LANGUAGE': 'en_US:en', 15:21:43 INFO - 'LOGNAME': 'cltbld', 15:21:43 INFO - 'MAIL': '/var/mail/cltbld', 15:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:43 INFO - 'MOZ_NO_REMOTE': '1', 15:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:43 INFO - 'NO_EM_RESTART': '1', 15:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:43 INFO - 'SHELL': '/bin/bash', 15:21:43 INFO - 'SHLVL': '1', 15:21:43 INFO - 'TERM': 'linux', 15:21:43 INFO - 'TMOUT': '86400', 15:21:43 INFO - 'USER': 'cltbld', 15:21:43 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:43 INFO - '_': '/tools/buildbot/bin/python'} 15:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:43 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 15:21:43 INFO - Cleaning up... 15:21:43 INFO - Return code: 0 15:21:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:21:43 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')]} 15:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:43 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')]} 15:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:43 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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:43 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 15:21:43 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 15:21:43 INFO - Using env: {'DISPLAY': ':0', 15:21:43 INFO - 'HOME': '/home/cltbld', 15:21:43 INFO - 'LANG': 'en_US.UTF-8', 15:21:43 INFO - 'LANGUAGE': 'en_US:en', 15:21:43 INFO - 'LOGNAME': 'cltbld', 15:21:43 INFO - 'MAIL': '/var/mail/cltbld', 15:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:43 INFO - 'MOZ_NO_REMOTE': '1', 15:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:43 INFO - 'NO_EM_RESTART': '1', 15:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:43 INFO - 'SHELL': '/bin/bash', 15:21:43 INFO - 'SHLVL': '1', 15:21:43 INFO - 'TERM': 'linux', 15:21:43 INFO - 'TMOUT': '86400', 15:21:43 INFO - 'USER': 'cltbld', 15:21:43 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:43 INFO - '_': '/tools/buildbot/bin/python'} 15:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:43 INFO - Downloading/unpacking psutil>=0.7.1 15:21:43 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 15:21:43 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 15:21:43 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 15:21:43 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 15:21:43 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 15:21:43 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 15:21:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:21:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:21:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:45 INFO - Installing collected packages: psutil 15:21:45 INFO - Running setup.py install for psutil 15:21:45 INFO - building 'psutil._psutil_linux' extension 15:21:45 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 15:21:45 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 15:21:45 INFO - building 'psutil._psutil_posix' extension 15:21:45 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 15:21:45 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 15:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:45 INFO - Successfully installed psutil 15:21:45 INFO - Cleaning up... 15:21:45 INFO - Return code: 0 15:21:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:45 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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:45 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 15:21:45 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 15:21:45 INFO - Using env: {'DISPLAY': ':0', 15:21:45 INFO - 'HOME': '/home/cltbld', 15:21:45 INFO - 'LANG': 'en_US.UTF-8', 15:21:45 INFO - 'LANGUAGE': 'en_US:en', 15:21:45 INFO - 'LOGNAME': 'cltbld', 15:21:45 INFO - 'MAIL': '/var/mail/cltbld', 15:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:45 INFO - 'MOZ_NO_REMOTE': '1', 15:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:45 INFO - 'NO_EM_RESTART': '1', 15:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:45 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:45 INFO - 'SHELL': '/bin/bash', 15:21:45 INFO - 'SHLVL': '1', 15:21:45 INFO - 'TERM': 'linux', 15:21:45 INFO - 'TMOUT': '86400', 15:21:45 INFO - 'USER': 'cltbld', 15:21:45 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:45 INFO - '_': '/tools/buildbot/bin/python'} 15:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:21:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:21:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:21:47 INFO - Installing collected packages: mozsystemmonitor 15:21:47 INFO - Running setup.py install for mozsystemmonitor 15:21:48 INFO - Successfully installed mozsystemmonitor 15:21:48 INFO - Cleaning up... 15:21:48 INFO - Return code: 0 15:21:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:21: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')]} 15:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:48 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 15:21:48 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 15:21:48 INFO - Using env: {'DISPLAY': ':0', 15:21:48 INFO - 'HOME': '/home/cltbld', 15:21:48 INFO - 'LANG': 'en_US.UTF-8', 15:21:48 INFO - 'LANGUAGE': 'en_US:en', 15:21:48 INFO - 'LOGNAME': 'cltbld', 15:21:48 INFO - 'MAIL': '/var/mail/cltbld', 15:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:48 INFO - 'MOZ_NO_REMOTE': '1', 15:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:48 INFO - 'NO_EM_RESTART': '1', 15:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:48 INFO - 'SHELL': '/bin/bash', 15:21:48 INFO - 'SHLVL': '1', 15:21:48 INFO - 'TERM': 'linux', 15:21:48 INFO - 'TMOUT': '86400', 15:21:48 INFO - 'USER': 'cltbld', 15:21:48 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:48 INFO - '_': '/tools/buildbot/bin/python'} 15:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:48 INFO - Downloading/unpacking blobuploader==1.2.4 15:21:48 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 15:21:48 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 15:21:48 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 15:21:48 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 15:21:48 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 15:21:48 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 15:21:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:21:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:21:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:21:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:21:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:21:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:50 INFO - Downloading docopt-0.6.1.tar.gz 15:21:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:21:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:21:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:21:50 INFO - Running setup.py install for blobuploader 15:21:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:21:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:21:50 INFO - Running setup.py install for requests 15:21:51 INFO - Running setup.py install for docopt 15:21:51 INFO - Successfully installed blobuploader requests docopt 15:21:51 INFO - Cleaning up... 15:21:51 INFO - Return code: 0 15:21:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:21: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')]} 15:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:51 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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:51 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 15:21:51 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 15:21:51 INFO - Using env: {'DISPLAY': ':0', 15:21:51 INFO - 'HOME': '/home/cltbld', 15:21:51 INFO - 'LANG': 'en_US.UTF-8', 15:21:51 INFO - 'LANGUAGE': 'en_US:en', 15:21:51 INFO - 'LOGNAME': 'cltbld', 15:21:51 INFO - 'MAIL': '/var/mail/cltbld', 15:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:51 INFO - 'MOZ_NO_REMOTE': '1', 15:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:51 INFO - 'NO_EM_RESTART': '1', 15:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:51 INFO - 'SHELL': '/bin/bash', 15:21:51 INFO - 'SHLVL': '1', 15:21:51 INFO - 'TERM': 'linux', 15:21:51 INFO - 'TMOUT': '86400', 15:21:51 INFO - 'USER': 'cltbld', 15:21:51 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:51 INFO - '_': '/tools/buildbot/bin/python'} 15:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:21:51 INFO - Running setup.py (path:/tmp/pip-vjCRQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:21:51 INFO - Running setup.py (path:/tmp/pip-RZDE5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:21:51 INFO - Running setup.py (path:/tmp/pip-8GZ5gV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:21:51 INFO - Running setup.py (path:/tmp/pip-nrvlJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:21:51 INFO - Running setup.py (path:/tmp/pip-YPbQb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:21:51 INFO - Running setup.py (path:/tmp/pip-oqX7m3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:21:51 INFO - Running setup.py (path:/tmp/pip-pA0qW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:21:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:21:51 INFO - Running setup.py (path:/tmp/pip-wKF7eC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:21:52 INFO - Running setup.py (path:/tmp/pip-aDW_Yc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:21:52 INFO - Running setup.py (path:/tmp/pip-Fojstl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:21:52 INFO - Running setup.py (path:/tmp/pip-TUx22h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:21:52 INFO - Running setup.py (path:/tmp/pip-R6ZLQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:21:52 INFO - Running setup.py (path:/tmp/pip-wSKOt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:21:52 INFO - Running setup.py (path:/tmp/pip-Wccs61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:21:52 INFO - Running setup.py (path:/tmp/pip-n4_AEa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:21:52 INFO - Running setup.py (path:/tmp/pip-mcqD_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:21:52 INFO - Running setup.py (path:/tmp/pip-xN2euU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:21:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:52 INFO - Running setup.py install for manifestparser 15:21:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:21:52 INFO - Running setup.py install for mozcrash 15:21:52 INFO - Running setup.py install for mozdebug 15:21:52 INFO - Running setup.py install for mozdevice 15:21:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for mozfile 15:21:53 INFO - Running setup.py install for mozhttpd 15:21:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for mozinfo 15:21:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for mozInstall 15:21:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for mozleak 15:21:53 INFO - Running setup.py install for mozlog 15:21:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for moznetwork 15:21:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:21:53 INFO - Running setup.py install for mozprocess 15:21:53 INFO - Running setup.py install for mozprofile 15:21:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:21:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:21:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:21:54 INFO - Running setup.py install for mozrunner 15:21:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:21:54 INFO - Running setup.py install for mozscreenshot 15:21:54 INFO - Running setup.py install for moztest 15:21:54 INFO - Running setup.py install for mozversion 15:21:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:21:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:54 INFO - Cleaning up... 15:21:54 INFO - Return code: 0 15:21:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:21: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')]} 15:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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/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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21: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/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 15:21: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/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 15:21:54 INFO - Using env: {'DISPLAY': ':0', 15:21:54 INFO - 'HOME': '/home/cltbld', 15:21:54 INFO - 'LANG': 'en_US.UTF-8', 15:21:54 INFO - 'LANGUAGE': 'en_US:en', 15:21:54 INFO - 'LOGNAME': 'cltbld', 15:21:54 INFO - 'MAIL': '/var/mail/cltbld', 15:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:54 INFO - 'MOZ_NO_REMOTE': '1', 15:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:54 INFO - 'NO_EM_RESTART': '1', 15:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:54 INFO - 'SHELL': '/bin/bash', 15:21:54 INFO - 'SHLVL': '1', 15:21:54 INFO - 'TERM': 'linux', 15:21:54 INFO - 'TMOUT': '86400', 15:21:54 INFO - 'USER': 'cltbld', 15:21:54 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:54 INFO - '_': '/tools/buildbot/bin/python'} 15:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:21:54 INFO - Running setup.py (path:/tmp/pip-CoyMwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:21:54 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)) 15:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:21:54 INFO - Running setup.py (path:/tmp/pip-vYhNhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:21:54 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)) 15:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:21:54 INFO - Running setup.py (path:/tmp/pip-NuB8C0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:21:54 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)) 15:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:21:54 INFO - Running setup.py (path:/tmp/pip-9GSPJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:21:54 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)) 15:21:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:21:54 INFO - Running setup.py (path:/tmp/pip-BgE_tr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:21:55 INFO - Running setup.py (path:/tmp/pip-qz1nEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:21:55 INFO - Running setup.py (path:/tmp/pip-CJFiVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:21:55 INFO - Running setup.py (path:/tmp/pip-3RGr_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:21:55 INFO - Running setup.py (path:/tmp/pip-5_twI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:21:55 INFO - Running setup.py (path:/tmp/pip-FOH1lS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:21:55 INFO - Running setup.py (path:/tmp/pip-mnDrND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:21:55 INFO - Running setup.py (path:/tmp/pip-D90NB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:21:55 INFO - Running setup.py (path:/tmp/pip-y7H9xc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:21:55 INFO - Running setup.py (path:/tmp/pip-_VbEZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:21:55 INFO - Running setup.py (path:/tmp/pip-DNonHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:21:55 INFO - Running setup.py (path:/tmp/pip-Nx8VvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:21:55 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)) 15:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:21:55 INFO - Running setup.py (path:/tmp/pip-iCuGnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:21:55 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)) 15:21:55 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)) 15:21:55 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)) 15:21:55 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)) 15:21: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:21:55 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)) 15:21:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:57 INFO - Downloading blessings-1.5.1.tar.gz 15:21:57 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 15:21:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:57 INFO - Installing collected packages: blessings 15:21:57 INFO - Running setup.py install for blessings 15:21:57 INFO - Successfully installed blessings 15:21:57 INFO - Cleaning up... 15:21:57 INFO - Return code: 0 15:21:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:21:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:21:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:21:58 INFO - Reading from file tmpfile_stdout 15:21:58 INFO - Current package versions: 15:21:58 INFO - argparse == 1.2.1 15:21:58 INFO - blessings == 1.5.1 15:21:58 INFO - blobuploader == 1.2.4 15:21:58 INFO - docopt == 0.6.1 15:21:58 INFO - manifestparser == 1.1 15:21:58 INFO - mozInstall == 1.12 15:21:58 INFO - mozcrash == 0.16 15:21:58 INFO - mozdebug == 0.1 15:21:58 INFO - mozdevice == 0.47 15:21:58 INFO - mozfile == 1.2 15:21:58 INFO - mozhttpd == 0.7 15:21:58 INFO - mozinfo == 0.9 15:21:58 INFO - mozleak == 0.1 15:21:58 INFO - mozlog == 3.1 15:21:58 INFO - moznetwork == 0.27 15:21:58 INFO - mozprocess == 0.22 15:21:58 INFO - mozprofile == 0.28 15:21:58 INFO - mozrunner == 6.11 15:21:58 INFO - mozscreenshot == 0.1 15:21:58 INFO - mozsystemmonitor == 0.0 15:21:58 INFO - moztest == 0.7 15:21:58 INFO - mozversion == 1.4 15:21:58 INFO - psutil == 3.1.1 15:21:58 INFO - requests == 1.2.3 15:21:58 INFO - wsgiref == 0.1.2 15:21:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:58 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 15:21:58 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 15:21:58 INFO - Using env: {'DISPLAY': ':0', 15:21:58 INFO - 'HOME': '/home/cltbld', 15:21:58 INFO - 'LANG': 'en_US.UTF-8', 15:21:58 INFO - 'LANGUAGE': 'en_US:en', 15:21:58 INFO - 'LOGNAME': 'cltbld', 15:21:58 INFO - 'MAIL': '/var/mail/cltbld', 15:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:58 INFO - 'MOZ_NO_REMOTE': '1', 15:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:58 INFO - 'NO_EM_RESTART': '1', 15:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:58 INFO - 'SHELL': '/bin/bash', 15:21:58 INFO - 'SHLVL': '1', 15:21:58 INFO - 'TERM': 'linux', 15:21:58 INFO - 'TMOUT': '86400', 15:21:58 INFO - 'USER': 'cltbld', 15:21:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:58 INFO - '_': '/tools/buildbot/bin/python'} 15:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 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)) 15:21:58 INFO - Cleaning up... 15:21:58 INFO - Return code: 0 15:21:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:21:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:21:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:21:58 INFO - Using env: {'DISPLAY': ':0', 15:21:58 INFO - 'HOME': '/home/cltbld', 15:21:58 INFO - 'LANG': 'en_US.UTF-8', 15:21:58 INFO - 'LANGUAGE': 'en_US:en', 15:21:58 INFO - 'LOGNAME': 'cltbld', 15:21:58 INFO - 'MAIL': '/var/mail/cltbld', 15:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:58 INFO - 'MOZ_NO_REMOTE': '1', 15:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:58 INFO - 'NO_EM_RESTART': '1', 15:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:21:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:21:58 INFO - 'SHELL': '/bin/bash', 15:21:58 INFO - 'SHLVL': '1', 15:21:58 INFO - 'TERM': 'linux', 15:21:58 INFO - 'TMOUT': '86400', 15:21:58 INFO - 'USER': 'cltbld', 15:21:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:58 INFO - '_': '/tools/buildbot/bin/python'} 15:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:58 INFO - Downloading/unpacking jsonschema 15:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:00 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 15:22:00 INFO - Downloading/unpacking functools32 (from jsonschema) 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:22:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:00 INFO - warning: no files found matching '*.txt' 15:22:00 INFO - no previously-included directories found matching 'build' 15:22:00 INFO - no previously-included directories found matching 'dist' 15:22:00 INFO - no previously-included directories found matching '.git*' 15:22:00 INFO - Installing collected packages: jsonschema, functools32 15:22:00 INFO - Running setup.py install for functools32 15:22:00 INFO - warning: no files found matching '*.txt' 15:22:00 INFO - no previously-included directories found matching 'build' 15:22:00 INFO - no previously-included directories found matching 'dist' 15:22:00 INFO - no previously-included directories found matching '.git*' 15:22:00 INFO - Successfully installed jsonschema functools32 15:22:00 INFO - Cleaning up... 15:22:00 INFO - Return code: 0 15:22:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60a890ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, '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': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', '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 15:22:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:22:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:22:00 INFO - Using env: {'DISPLAY': ':0', 15:22:00 INFO - 'HOME': '/home/cltbld', 15:22:00 INFO - 'LANG': 'en_US.UTF-8', 15:22:00 INFO - 'LANGUAGE': 'en_US:en', 15:22:00 INFO - 'LOGNAME': 'cltbld', 15:22:00 INFO - 'MAIL': '/var/mail/cltbld', 15:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:00 INFO - 'MOZ_NO_REMOTE': '1', 15:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:00 INFO - 'NO_EM_RESTART': '1', 15:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:22:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:22:00 INFO - 'SHELL': '/bin/bash', 15:22:00 INFO - 'SHLVL': '1', 15:22:00 INFO - 'TERM': 'linux', 15:22:00 INFO - 'TMOUT': '86400', 15:22:00 INFO - 'USER': 'cltbld', 15:22:00 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:00 INFO - '_': '/tools/buildbot/bin/python'} 15:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:00 INFO - Downloading/unpacking flake8 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:22:02 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 15:22:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:22:02 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 15:22:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:03 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 15:22:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:22:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:03 INFO - no previously-included directories found matching 'docs/_build' 15:22:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:22:03 INFO - Running setup.py install for pep8 15:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:03 INFO - no previously-included directories found matching 'docs/_build' 15:22:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:22:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:22:03 INFO - Cleaning up... 15:22:03 INFO - Return code: 0 15:22:03 INFO - Running post-action listener: _resource_record_post_action 15:22:03 INFO - Running post-action listener: _start_resource_monitoring 15:22:03 INFO - Starting resource monitoring. 15:22:03 INFO - ##### 15:22:03 INFO - ##### Running install step. 15:22:03 INFO - ##### 15:22:03 INFO - Running pre-action listener: _resource_record_pre_action 15:22:03 INFO - Running main action method: install 15:22:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:22:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:22:03 INFO - Reading from file tmpfile_stdout 15:22:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:22:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:22:03 INFO - Reading from file tmpfile_stdout 15:22:03 INFO - Output received: 15:22:03 INFO - Usage: mozinstall [options] installer 15:22:03 INFO - Options: 15:22:03 INFO - -h, --help show this help message and exit 15:22:03 INFO - -d DEST, --destination=DEST 15:22:03 INFO - Directory to install application into. [default: 15:22:03 INFO - "/builds/slave/test-pgo"] 15:22:03 INFO - --app=APP Application being installed. [default: firefox] 15:22:03 INFO - mkdir: /builds/slave/test-pgo/build/application 15:22:03 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'] 15:22:03 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 15:22:19 INFO - Reading from file tmpfile_stdout 15:22:19 INFO - Output received: 15:22:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:22:19 INFO - Running post-action listener: _resource_record_post_action 15:22:19 INFO - ##### 15:22:19 INFO - ##### Running run-tests step. 15:22:19 INFO - ##### 15:22:19 INFO - Running pre-action listener: _resource_record_pre_action 15:22:19 INFO - Running main action method: run_tests 15:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:22:19 INFO - Python 2.7.3 15:22:19 INFO - Return code: 0 15:22:19 INFO - grabbing minidump binary from tooltool 15:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:19 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 0x2946840>, '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 0x28b36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:22:19 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 15:22:19 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 15:22:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:19 INFO - Return code: 0 15:22:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:22:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:22:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:22:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:22:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:22:20 INFO - Return code: 0 15:22:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 15:22:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 15:22:20 INFO - Using env: {'DISPLAY': ':0', 15:22:20 INFO - 'HOME': '/home/cltbld', 15:22:20 INFO - 'LANG': 'en_US.UTF-8', 15:22:20 INFO - 'LANGUAGE': 'en_US:en', 15:22:20 INFO - 'LOGNAME': 'cltbld', 15:22:20 INFO - 'MAIL': '/var/mail/cltbld', 15:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:20 INFO - 'MOZ_NO_REMOTE': '1', 15:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:20 INFO - 'NO_EM_RESTART': '1', 15:22:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:22:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:22:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:22:20 INFO - 'SHELL': '/bin/bash', 15:22:20 INFO - 'SHLVL': '1', 15:22:20 INFO - 'TERM': 'linux', 15:22:20 INFO - 'TMOUT': '86400', 15:22:20 INFO - 'USER': 'cltbld', 15:22:20 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151', 15:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:20 INFO - '_': '/tools/buildbot/bin/python'} 15:22:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:22:20 INFO - mozversion application_buildid: 20151228113006 15:22:20 INFO - mozversion application_changeset: 7ce13695874558e5a60fc8d4758553d7913e43dd 15:22:20 INFO - mozversion application_display_name: Nightly 15:22:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:20 INFO - mozversion application_name: Firefox 15:22:20 INFO - mozversion application_remotingname: firefox 15:22:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 15:22:20 INFO - mozversion application_vendor: Mozilla 15:22:20 INFO - mozversion application_version: 46.0a1 15:22:20 INFO - mozversion platform_buildid: 20151228113006 15:22:20 INFO - mozversion platform_changeset: 7ce13695874558e5a60fc8d4758553d7913e43dd 15:22:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 15:22:20 INFO - mozversion platform_version: 46.0a1 15:22:20 INFO - using testdate: 1451344940 15:22:20 INFO - actual date: 1451344940 15:22:21 INFO - starting webserver on 'localhost:50229' 15:22:21 INFO - SUITE-START | Running 3 tests 15:22:21 INFO - TEST-START | dromaeo_css 15:22:21 INFO - operating with platform_type : linux_ 15:22:21 INFO - Initialising browser for dromaeo_css test... 15:22:21 INFO - TEST-INFO | started process 8630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpovT3vn/profile http://localhost:50229/getInfo.html) 15:22:25 INFO - PROCESS | 8630 | __metrics Screen width/height:1600/1200 15:22:25 INFO - PROCESS | 8630 | colorDepth:24 15:22:25 INFO - PROCESS | 8630 | Browser inner width/height: 1024/697 15:22:25 INFO - PROCESS | 8630 | __metrics 15:22:25 INFO - PROCESS | 8630 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:22:25 INFO - PROCESS | 8630 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:26 INFO - TEST-INFO | 8630: exit 0 15:22:26 INFO - Browser initialized. 15:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:26 INFO - TEST-INFO | started process 8724 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpovT3vn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:38 INFO - PROCESS | 8724 | RSS: Main: 150360064 15:22:38 INFO - PROCESS | 8724 | 15:23:30 INFO - PROCESS | 8724 | 1451345010120 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] 15:25:39 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50229/tests/dromaeo/cssquery-ext.html) 15:25:40 INFO - PROCESS | 8724 | RSS: Main: 263278592 15:25:40 INFO - PROCESS | 8724 | 15:28:42 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-ext.html (next: http://localhost:50229/tests/dromaeo/cssquery-jquery.html) 15:28:43 INFO - PROCESS | 8724 | RSS: Main: 237367296 15:28:43 INFO - PROCESS | 8724 | 15:31:45 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50229/tests/dromaeo/cssquery-mootools.html) 15:31:45 INFO - PROCESS | 8724 | RSS: Main: 233934848 15:31:45 INFO - PROCESS | 8724 | 15:34:47 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50229/tests/dromaeo/cssquery-prototype.html) 15:34:48 INFO - PROCESS | 8724 | RSS: Main: 213282816 15:34:48 INFO - PROCESS | 8724 | 15:37:50 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50229/tests/dromaeo/cssquery-yui.html) 15:37:51 INFO - PROCESS | 8724 | RSS: Main: 217792512 15:37:51 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | Cycle 1(1): loaded http://localhost:50229/tests/dromaeo/cssquery-yui.html (next: http://localhost:50229/tests/dromaeo/cssquery-dojo.html) 15:40:53 INFO - PROCESS | 8724 | RSS: Main: 262553600 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | __start_tp_report 15:40:53 INFO - PROCESS | 8724 | _x_x_mozilla_page_load 15:40:53 INFO - PROCESS | 8724 | _x_x_mozilla_page_load_details 15:40:53 INFO - PROCESS | 8724 | |i|pagename|runs| 15:40:53 INFO - PROCESS | 8724 | |0;dojo.html;3154.9684503154967;3200.951985720213;3229.5963004624423;3233.8059716417;3259.006003169033;5152.768125434355;5265.420803711589;5323;5339.546138578221;5356.250124982505;5353.946460535393;5357.812476563321;5407.405185429599;5415.0523658359825;5418.024755544;4818.59041981432;4854.660173787827;4943.492234868364;5039.470855560168;5061.645684802065;4798.0643774464;4958.157113290749;4982.352294201749;5027.874303142414;5055.949440505603;4819.108464933981;4910.508949105097;4959.603231741488;4993.925091123636;5041.798328066873;4868.599470523671;4875.731834749123;4882;4882.218844984821;4925.187344088221;4803.687760295605;4848.127337079324;4851.442084160331;4884.511548845123;4918.877028074291;5087.847364579068;5098.260752190911;5186.818461353872;5189.091908915962;5213.061648903196;5678.517326027292;5683.971580142114;5688.800891968803;5689.231953686282;5712.971435142797;5693.259876216107;5694.6867922264255;5697.430256974311;5702.800401985911;5705.5720820938595;5344.22508736235;5356.464353564613;5438.483344082306;5440.183972404131;5455.8090466834265;5915.852103697442;5916.526677865761;5939.881202375928;5970.0746384310505;5977.462028417463;5674.546036317085;5713.771449141987;5717.685527295956;5729.312482502127;5751.424857514216;5713.628614140068;5743.655380677089;5750.223719797774;5815.214945982323;5889.734961926723;5648.181013752983;5665.263515742927;5673.262475878109;5686.061799803069;5706.828795136153;5653.378128405872;5662.915056274159;5663.292088488939;5670.489655930986;5672.574556908248;4271.188474189956;4356.019895523482;4400;4435.822567097344;4465.553444655573;3922.235164143022;3936.5079365079364;3960.6237407446247;3973.324534829086;3974.8012599370495;5294.523492885659;5302.019126461617;5308.46915308466;5315.760790764425;5351.678899266057;5568.470995255444;5685.005124103348;5694.231278777312;5728;5767.307923049261;5310.787568497294;5328.440513746078;5351.491608297206;5351.705656188869;5371.62398632092;4956.4547899731;4971.527704868032;4975.950240497621;4985.351904252424;5033.7734801934;5702.315722113373;5811.88376232473;5813.680247586423;5859.765609375662;5890.528757699288;5736.282964629421;5739;5756.740946657326;5763.452472015152;5798.507126894261;5877.35349111606;5882.323532793784;5883.735231914659;5888;5898.734556945034;5505.091659876236;5573.108302671553;5579.079451890392;5630.634008789416;5679.006173919465;5678.0915053591225;5720.08478643415;5729.770809167587;5775.971120144372;5816.621919575214;5568.359638641608;5572.0527510324155;5574.052411090043;5574.442555744393;5580.441955804549;5496.862578435571;5526.751296191601;5560.2493663356545;5582.218489411567;5611.859703507282;5478.643888147258;5483;5532.944670553243;5545.750441230073;5595.496405323541;5550.139728342114;5599.32808063035;5601.719914004365;5604.131359639263;5659.462351076641;5401.081816091352;5454.372747134131;5494.945050549443;5497.312835895513;5500.147477141049 15:40:53 INFO - PROCESS | 8724 | |1;ext.html;525.2961032216829;533.4665334665335;570.4352690836072;576.7721749908785;579.5132089045201;28317.433651326963;28958.710412895864;35363.64636353639;35879;35910.10224744383;39536.40695389564;39950.80024599873;39955.60044399555;40000.599994000055;40031;7376.815579610526;8516.8722469163;8681.262092722127;8681.609327580274;8696.34777391695;7465.962670186642;10186.388816670986;10389.948050259738;10413.427261500614;10432;10113.393196408239;10121.139703125207;10135.49322533874;10220.642277520288;10225;7573.734919277799;7732.845343093107;9911.207103431745;9957.850632240523;10268.332558383681;9903.752406189831;9927.652532161339;9976.650817221362;10038.749031274203;10046.346987445793;36522.086947826254;36910.26179476422;36920.70777522774;37202;37267.62732372669;3110.440120778259;3183.554302397666;3242.8054316741072;3932.941005884914;4153.293940030172;28931.710682893114;29218.853905730546;29327.12018639444;29350.559741603895;31336.529952050736;3786.2048969716393;3971.721979461439;3982.780947047911;4039.434479172918;4162.6253637172495;217218;218474;218738;218817;218915;55535.444645553835;55596.72201639047;55846;55899.441005589426;55964.72017639967;58999;59144.40855591475;59147.40852591419;59159.704201478715;64346;13963.79054314186;14131.576052718436;14132.505362312475;14138.575842724735;14142.151470911573;10625.415602141957;10689.144868410509;10689.9465502672;10694.358338499715;10704;19473.8052619472;20409.48976275605;20425.38723838287;20612.58774824495;20678.689819652718;6752;7885.369170466349;8038.196180381915;8113.5131892086665;8350.582470876432;933.1927882381826;959.5010594490826;980.9117179453883;1044.5612842606124;1122.320995797547;27627.585586216224;28725.56911646327;28978.855105724335;29034.716928833393;29103.708962910525;1055.889131641182;1126.0709914320719;1145.8395824584566;1147.8794726553758;1180.7579446213676;14165.291735413188;14877.925610371878;14951.626209344637;15292.923535382251;15346.693066138614;247748;252309;252332;252338;252611;48402.27396589054;48873.51126488761;48911.26633100506;48951.265731014064;49133.50866491361;1346.0981142634262;1373.5604606526015;1380.151207007683;1387.8681525255286;1392.394308475796;26838.731612683623;27920.720792791813;29567.852160739058;29589.112326630235;30022.69977300199;50154.49845501498;51294.74352628213;51362;51373.22940155826;51388.48611513837;241793;247403;247496;247637;248033;37366.62633373631;38027.80986095052;43744.343834841864;43869.78065109782;44414.77792611016;39912;40388.394174086825;40658.79670601628;40696.3895541573;41086.794566026976;34000;35296;37757.244855102195;37774.811125944194;38949;33419.331613368086;34471.9339985798;34565.30869382648;36877.26245475129;37169.25661486701;36513.45229821608;36973.81513092525;37151.6284837159;37426;37652.623473764914;31211;32921;33205;33237.50143747894;33282.66717332796;24838.254852354457;25102.497950041263;25569.360765980255;25621.34830342269;25737.227883163534 15:40:53 INFO - PROCESS | 8724 | |2;jquery.html;351.53772788782766;360.49170669356215;360.61594401961906;365.1929236387583;365.2895118993557;14108.929455352734;14174.645633859158;16407;16765;17444.389446369365;16446.177691115427;16529.50411487654;16816.57958551034;16830.410935617227;16869.07220102897;5379.919301210475;5496.725163741817;5512.145617429305;5513.035218836708;5515;4024.859129930453;4142.937855932163;5451.918221226685;5513.862153446176;5803.941960580382;5874.060150375941;5898.911516327258;5911.911321330162;5919.970400147993;5926.081457374093;5656.604037717361;5856.414358564152;5860.853478663067;5865.648061116347;5873.823785286449;5078.720670363128;5093.414257360414;5134.563562097226;5138.897222055538;5161.61287903405;19382.70925936112;20129.698054529195;20151.697724534144;20576;20954.476138096517;2089.686547017944;2171.0989939175383;2190.452386903274;2262.242148880127;2747.079728291025;13115.344232788322;13174.143680660822;13175.209487430784;13579.321033948361;13652.317384130754;1804.3684710351404;1815.174095786414;1831.0753069699717;1897.5256185953513;1898.4209816006112;57455.42544574542;60345;60594.09108863371;60966;61058.694706526185;9325.860112098324;9413.435193888388;9593.328467007243;9595.088466595662;9633.807323853483;12478.937605311916;12493.562725304571;12499.812502812465;12500.24998500093;12573.057020723483;7229.674664639999;7236.204017558064;7261.745838895613;7383.409327253807;7458.962705186548;7191.137063552407;7210.2789721027475;7226.168990566047;7226.205117437078;7280.017197678351;5777.653340799566;5787.276590426197;5792.768289268466;5855;5950.434708702666;1645.7120003999253;1721.3544920654754;1725.7402096469395;1750.2561411400104;1764.8941063536229;921.6543796076471;925.4817302310728;950.9619615215453;997.9072915157891;1043.4991204221865;16026.278817453243;16115.758263626056;16585.419510317322;16820.74768878468;16876.15619219034;846.530175752451;885.1526764742242;892.9107089291149;901.2699713232303;996.566493575297;9610.759731006641;9760.316777825485;10274.640387586398;10281.383117012854;10387.636432724817;567961;576449;591048;591325;596282.0185899129;71004.93492597615;72856.63571682214;73540.63229683817;76544.23455765483;83263.5836820812;1156.9247998880214;1160.7678464307342;1204.9638510844688;1219.9451024703733;1227.4844565282604;14679.266036697909;15219.543413697607;15539.922300388425;15688.529344119695;16281.267342969832;35141.824290879405;35411.645883540834;36620.26759464849;36670.266594668494;36688;48208.276875847594;48355.5164448351;48850.022999540524;48894.75552622214;49321.50678493169;9352.766180845534;9641.42151470914;10059.19526437898;10100.090991810772;10164.593416263267;17399.913000434917;17594.560135996704;17790.37733679315;17807.554811129306;18098.366557170437;14472.927635362177;14581.489647862274;14772.926135369255;14816.185109819064;15215.391384344503;14281.857181428053;14343;14502;14558.4904528341;14823.036502627294;12144.14990950625;13541.59375218745;14258.572242832732;14702.632434188803;14828;9251.814963700823;9324.393914395543;9396.812063758549;9403.153716165578;9418.858717119112;9846.950765246127;9868.605255789687;10496.947515262375;14171.893541277952;14328.355224015153 15:40:53 INFO - PROCESS | 8724 | |3;mootools.html;1324.5628942448993;1484.6511069898575;1498.258362110755;1658.6599747051855;1818.0455260987972;6467.870642587145;7135.85728285434;7281.308275713805;7287.635618219095;7291.7447889323885;7135.89296160558;7292.7447539336135;7294.817629559264;7296.70813167474;7319.7438089666875;1976.3873199308189;2006.167440512193;2175.673648952654;2229.308914236584;2262.4457008033055;2254.256095488493;2265.762094980028;2274.090363854455;2274.2040285899966;2274.431392151962;2155.892205389732;2206.5145667953107;2215.0364591402713;2223.2218723446745;2230.587341341857;2221.6556433752794;2227.13141874669;2251.2908433843368;2251.864888106719;2258.153192552793;2267.977320226793;2280.8631482111127;2307.3654744945106;2308.2382813671616;2314.351981445198;7332.30343117403;7418.851622967564;7424.628768561551;7432.554046757212;7434.033575635187;4423.1153769246275;4506.7070640408265;4509.368688383629;4528.8641340759505;4535.024969631512;2973.717496837797;2995.6405231372155;3028.9848550757106;3035.043961152252;3101.5037593984853;903.4308385716956;906.8775715278418;914.401067300919;949.1125797379403;952.9285303602188;9990.35062720928;10025.097741203253;10040.246981476419;10073.395596264247;10083.495825208784;4081.69387295954;4085.3667681509414;4138.6482149017065;4163.084121493267;4172.374143878443;8566.700165494178;8569.528675922884;8578.656853725906;8584.184502472255;8586.270167035747;4564.748938808398;4565.292379681155;4566.589006989387;4568.383268258809;4570.223062079454;4104.979475102665;4164.770937598461;4165.520965089054;4179.6029377209115;4180.352045432963;3294.3081952789703;3329.034579971781;3505.6669616386403;3511.122219445139;3557.626449222846;1131.7906187355366;1146.507001989136;1149.4425203776161;1151.3725019864194;1157.774234024374;1022.4632068164125;1031.03083101884;1033.0341131042499;1161.8257261410856;1341.5706973768495;6835.760748373783;6865.656717164122;6914.032035515032;6915.51591388608;6928.4803639726215;1100.0759362135843;1105.1932089574655;1112.9109671226283;1117.7764447110449;1119.8488204092507;5518.2826232590305;5598.300212473441;5601.075822489243;5604.467575580314;5605.5795815313195;8415.95792021036;8477.660893564189;8650.95674521636;8651.783705407415;8725.127487251224;8439.198276163877;8439.70461033861;8458.407911446262;8539.14608539141;8541.444806087584;6737.124173857465;6760.1549806274215;6808.489363297674;6826.556273842284;6883.7590684325805;6893.482988775761;6957.478189135936;6968.268331825288;6979.616121113185;6987.091678081817;7520.811979700551;7692.153863074946;7793.532388056735;7870.134285228734;7895;8030.718924837603;8031.357491400557;8182.918170818216;8288.792780180302;8298.170182981896;6563.671816409065;6639.601623902581;6666.666666666551;6705.362990516089;6706.83232919181;6231.937680623136;6335.827871843724;6780.423663988616;6965.407940325129;6975.7209711612995;6586.37429444202;6628.105205797348;6656.334366563498;6766.8646627068165;6772.7290908365085;6515.218173818982;6575.835604109936;6606.075149478981;6707.8323041922395;6768.56004359715;6427.228732552124;6467.126937863516;6483.319251478715;6488.805335839932;6499.545031847725;6110.144579758926;6151.630902145886;6208.689565521796;6223.159873417212;6223.3465486123305;6054.273487181566;6122.112293717297;6139.570230083851;6145.231846019247;6147.96926015385 15:40:53 INFO - PROCESS | 8724 | |4;prototype.html;332.5992179423795;336.7322978232305;338.32335329341316;340.48926610084874;348.1869833937755;6102.694865256742;6120.69396530174;6131.834951359238;6143.354947730485;6143.877122457559;5836.503897168735;5927.673977931223;5981.252343457068;6013.789517366893;6126.7855625053135;4683.976580117094;4686.437627484698;4686.46105697844;4698.295255711637;4706.458757242926;4481.148581769454;4699.577038066574;4702.318163866237;4706.3411122442885;4706.929396059062;4506.346579745935;4516.954830451687;4608.1474927138415;4616.97691511542;4636.281376386665;4611.262198048313;4627.167109920213;4641.930371044403;4642.396488456513;4658.86023419298;4079.8572049978407;4080.9387859182134;4084.8570300039355;4087.976451656419;4099.815508302134;5649.943500565024;5790.189373487715;5792.044312688401;5802.535797136219;5805.796797112081;5366.812161574326;5399.406065332811;5402.8919421611745;5414.593905457106;5432.456754324576;6534.281229064799;6537.869242615121;6539.9673001635165;6540.4440622547145;6547.148870646785;4476.328550717386;4477.059817438342;4478.41780568524;4481.417415735966;4484.730916145042;6627.768028118992;6738.056672065914;6799.7280108796085;6805.047293378931;6807.693653785592;4432.246518091933;4438.667099967515;4444.044530425974;4447.310666846644;4448.510663826976;4485.237509623306;4500.929572396734;4501.7974191161475;4507.797149128297;4509.436320459942;5265.21021846726;5271.551918087006;5273;5282.498162674539;5295.841124766263;6414.358564143642;6535.8692826143215;6554.377334153248;6556.5738227016045;6566.146400967844;1617.102508107988;1641.2204203003478;1643.3919449803411;1643.8109617393914;1644.6792875389424;1062.9893701063045;1075.2688172043086;1075.8493810866485;1084.978300433987;1095.46322302073;6198.938010619836;6204.317525072239;6204.906926396107;6214;6214.875702485925;6536.705848236841;6765.086713293741;6766.188057433041;6766.25571187169;6768.018637297564;6110.327863934964;6142.109394137825;6207.534434917309;6232.501399887998;6238.469730072995;3651.9634803652157;3663.432168013962;3676.540432445944;3682;3696.926061478809;6872.862542749117;6989.33601307875;7038.753643622551;7064.1876184238445;7077.82305442368;6920.515563910478;6923.792286231421;6926.238113807477;6932.757353492704;6938.444924406035;7000.334968178015;7035.542689725152;7043.7534686285735;7046.788596342016;7047.189573199045;6539.21529416454;6703.631300278336;6770.93229067703;6771.898421523582;6773.288804675438;6624.701888415129;6713.328667133248;6721;6721.596704197764;6728.293529179561;7067.328603782633;7076.2923707628825;7077.787666370017;7085.185203701641;7091.361777440055;4446.488653804854;4563.612092972002;4608.930866036945;4609.631229501699;4612.100640375094;6687;6694.83262918431;6697.129373181455;6741.52809303344;6781.457483401415;6587.374199451045;6589.80230593083;6593.175853018372;6601.570897891622;6605.900911486236;6353.078803573549;6549.901751473827;6560.704768285344;6586.637734924433;6591.110200123114;6423.8394040147505;6438.710258038306;6439.613623182624;6444.387783160592;6445.871082578416;6554.442872355903;6578.309277525791;6587.868242635024;6590.044443555754;6590.80227593173;6237.96881015592;6335.683215839097;6360.840978975378;6431.774887878902;6436.8390790230615 15:40:53 INFO - PROCESS | 8724 | |5;yui.html;716.4948711158637;721.3003386714885;798.1858504325588;837.6230696186716;868.6655637579532;13771.862281377184;14009.369578368973;14025.719485610281;14034.789478157836;14046.859531404683;12638.368081595907;13135.868641313584;13227.470901163942;13230.338483075855;14509.274536273197;826.2852632472913;842.1999100854182;842.7556008757452;842.9494230346199;843.3632607381419;835.2274146414572;835.5905606252923;837.8491871463134;840.2731637133896;842.5744998775609;864.4683519635441;870.6386849457467;871.6949067826242;872.5637181409295;873.1137895036543;869.9608517616691;871.0766587417357;871.1245198575423;871.6731225790329;873.2228316798055;643.9227292724856;644.5455953552735;644.6067898581862;644.6969924135649;645.0227904724346;12978.935105324508;13590.25253611051;13623.04638675293;13673.863261367458;13710.108842925278;12745.87254127456;12797.680057998532;12978.091533592653;13109.47562097515;13334.33328333589;10692.144628429707;10764.192685548614;10989.285696429786;11176.888231117748;11182.217244792868;3639.6906262967677;3694.8891533253777;3761.9811900940595;3775.1505911170043;3846.807659617008;41929.58070419287;43878.78060609708;44073.77963110164;44206.33690494613;49600.255996160085;9932.702018939442;10014.39913605186;10151.289409741246;10194.541245643964;10292.742681433025;17308.65382692339;17398.56503587395;17421.216045277994;17424.91287543554;17426;7913.683452661944;8012.278894899487;8018;8067.556284404297;8164.591770411455;4288.549702281278;4404.471463424409;4417.337399390117;4449.1991441540185;4482.551744825557;3099.8450077496036;3115.470370037099;3121.547375630521;3126.6248050234117;3133.075742655922;585.5813093638069;586.8092869817326;591.8668299632549;595.8867815115115;613.0283500651517;648.6034103985821;664.3356643356643;682.1098466501164;685.3797313431353;688.9321551595008;8434.240918317259;8779.912200877909;8790.164934331227;8849.51327676984;8886.289096872235;589.6344266554763;618.4742968476759;652.5725649699455;659.7064306383613;662.7879078694772;4103.753774773523;4142.855000075043;4179.791010449465;4266.1254442839145;4324.827006919751;59138.40861591415;59500.70249648724;60740.69629651912;61025.69487152536;61050;51288.74355628198;51653;53094.20358694623;53366.466335336925;53963.460365396626;42562.78718606387;46854.765726171834;50075.9984800302;51927;52958.205626915624;8345.165483451849;8856.822863542822;9082.36423450352;9193.54032298369;9235.399699019543;28801.42397152087;37957.999999998894;38260.23479530338;38433;39717;45148.19407223674;46058.76970615125;46091;46188.30717539307;46896;11056.723581910517;11435.313881167156;11457.140714446616;11585;11725.061995040547;12383.62849114528;12489.31308778026;12563.685907852012;12614.936925315315;13068.346582671018;11588.246763960316;11712.70718232051;11845.526178952745;12127.81808272859;12498.937505312415;11334.206605537533;11622.94188529052;11673.357965311989;11964.581239656918;12337.50649973991;11375.829362559734;11542.653720388402;11641.47613357384;11653.126015548698;11988.76022479528;10064.144547713233;10084.445355505517;10388.731946047259;10536.473176341306;10574.2598018138;9345.953270233606;9767.316287859781;10083.647072352433;10170.135538479017;10192.745181370525 15:40:53 INFO - PROCESS | 8724 | __end_tp_report 15:40:53 INFO - PROCESS | 8724 | __start_cc_report 15:40:53 INFO - PROCESS | 8724 | _x_x_mozilla_cycle_collect,955 15:40:53 INFO - PROCESS | 8724 | __end_cc_report 15:40:53 INFO - PROCESS | 8724 | __startTimestamp1451346053860__endTimestamp 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | ------- Summary: start ------- 15:40:53 INFO - PROCESS | 8724 | Number of tests: 6 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#0] dojo.html Cycles:165 Average:5315.98 Median:5500.15 stddev:576.50 (10.5%) stddev-sans-first:552.78 15:40:53 INFO - PROCESS | 8724 | Values: 3155.0 3201.0 3229.6 3233.8 3259.0 5152.8 5265.4 5323.0 5339.5 5356.3 5353.9 5357.8 5407.4 5415.1 5418.0 4818.6 4854.7 4943.5 5039.5 5061.6 4798.1 4958.2 4982.4 5027.9 5055.9 4819.1 4910.5 4959.6 4993.9 5041.8 4868.6 4875.7 4882.0 4882.2 4925.2 4803.7 4848.1 4851.4 4884.5 4918.9 5087.8 5098.3 5186.8 5189.1 5213.1 5678.5 5684.0 5688.8 5689.2 5713.0 5693.3 5694.7 5697.4 5702.8 5705.6 5344.2 5356.5 5438.5 5440.2 5455.8 5915.9 5916.5 5939.9 5970.1 5977.5 5674.5 5713.8 5717.7 5729.3 5751.4 5713.6 5743.7 5750.2 5815.2 5889.7 5648.2 5665.3 5673.3 5686.1 5706.8 5653.4 5662.9 5663.3 5670.5 5672.6 4271.2 4356.0 4400.0 4435.8 4465.6 3922.2 3936.5 3960.6 3973.3 3974.8 5294.5 5302.0 5308.5 5315.8 5351.7 5568.5 5685.0 5694.2 5728.0 5767.3 5310.8 5328.4 5351.5 5351.7 5371.6 4956.5 4971.5 4976.0 4985.4 5033.8 5702.3 5811.9 5813.7 5859.8 5890.5 5736.3 5739.0 5756.7 5763.5 5798.5 5877.4 5882.3 5883.7 5888.0 5898.7 5505.1 5573.1 5579.1 5630.6 5679.0 5678.1 5720.1 5729.8 5776.0 5816.6 5568.4 5572.1 5574.1 5574.4 5580.4 5496.9 5526.8 5560.2 5582.2 5611.9 5478.6 5483.0 5532.9 5545.8 5595.5 5550.1 5599.3 5601.7 5604.1 5659.5 5401.1 5454.4 5494.9 5497.3 5500.1 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#1] ext.html Cycles:180 Average:41815.24 Median:34235.97 stddev:62008.28 (181.1%) stddev-sans-first:62104.72 15:40:53 INFO - PROCESS | 8724 | Values: 525.3 533.5 570.4 576.8 579.5 28317.4 28958.7 35363.6 35879.0 35910.1 39536.4 39950.8 39955.6 40000.6 40031.0 7376.8 8516.9 8681.3 8681.6 8696.3 7466.0 10186.4 10389.9 10413.4 10432.0 10113.4 10121.1 10135.5 10220.6 10225.0 7573.7 7732.8 9911.2 9957.9 10268.3 9903.8 9927.7 9976.7 10038.7 10046.3 36522.1 36910.3 36920.7 37202.0 37267.6 3110.4 3183.6 3242.8 3932.9 4153.3 28931.7 29218.9 29327.1 29350.6 31336.5 3786.2 3971.7 3982.8 4039.4 4162.6 217218.0 218474.0 218738.0 218817.0 218915.0 55535.4 55596.7 55846.0 55899.4 55964.7 58999.0 59144.4 59147.4 59159.7 64346.0 13963.8 14131.6 14132.5 14138.6 14142.2 10625.4 10689.1 10689.9 10694.4 10704.0 19473.8 20409.5 20425.4 20612.6 20678.7 6752.0 7885.4 8038.2 8113.5 8350.6 933.2 959.5 980.9 1044.6 1122.3 27627.6 28725.6 28978.9 29034.7 29103.7 1055.9 1126.1 1145.8 1147.9 1180.8 14165.3 14877.9 14951.6 15292.9 15346.7 247748.0 252309.0 252332.0 252338.0 252611.0 48402.3 48873.5 48911.3 48951.3 49133.5 1346.1 1373.6 1380.2 1387.9 1392.4 26838.7 27920.7 29567.9 29589.1 30022.7 50154.5 51294.7 51362.0 51373.2 51388.5 241793.0 247403.0 247496.0 247637.0 248033.0 37366.6 38027.8 43744.3 43869.8 44414.8 39912.0 40388.4 40658.8 40696.4 41086.8 34000.0 35296.0 37757.2 37774.8 38949.0 33419.3 34471.9 34565.3 36877.3 37169.3 36513.5 36973.8 37151.6 37426.0 37652.6 31211.0 32921.0 33205.0 33237.5 33282.7 24838.3 25102.5 25569.4 25621.3 25737.2 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#2] jquery.html Cycles:180 Average:30109.31 Median:365.24 stddev:95396.42 (26118.7%) stddev-sans-first:95637.86 15:40:53 INFO - PROCESS | 8724 | Values: 351.5 360.5 360.6 365.2 365.3 14108.9 14174.6 16407.0 16765.0 17444.4 16446.2 16529.5 16816.6 16830.4 16869.1 5379.9 5496.7 5512.1 5513.0 5515.0 4024.9 4142.9 5451.9 5513.9 5803.9 5874.1 5898.9 5911.9 5920.0 5926.1 5656.6 5856.4 5860.9 5865.6 5873.8 5078.7 5093.4 5134.6 5138.9 5161.6 19382.7 20129.7 20151.7 20576.0 20954.5 2089.7 2171.1 2190.5 2262.2 2747.1 13115.3 13174.1 13175.2 13579.3 13652.3 1804.4 1815.2 1831.1 1897.5 1898.4 57455.4 60345.0 60594.1 60966.0 61058.7 9325.9 9413.4 9593.3 9595.1 9633.8 12478.9 12493.6 12499.8 12500.2 12573.1 7229.7 7236.2 7261.7 7383.4 7459.0 7191.1 7210.3 7226.2 7226.2 7280.0 5777.7 5787.3 5792.8 5855.0 5950.4 1645.7 1721.4 1725.7 1750.3 1764.9 921.7 925.5 951.0 997.9 1043.5 16026.3 16115.8 16585.4 16820.7 16876.2 846.5 885.2 892.9 901.3 996.6 9610.8 9760.3 10274.6 10281.4 10387.6 567961.0 576449.0 591048.0 591325.0 596282.0 71004.9 72856.6 73540.6 76544.2 83263.6 1156.9 1160.8 1205.0 1219.9 1227.5 14679.3 15219.5 15539.9 15688.5 16281.3 35141.8 35411.6 36620.3 36670.3 36688.0 48208.3 48355.5 48850.0 48894.8 49321.5 9352.8 9641.4 10059.2 10100.1 10164.6 17399.9 17594.6 17790.4 17807.6 18098.4 14472.9 14581.5 14772.9 14816.2 15215.4 14281.9 14343.0 14502.0 14558.5 14823.0 12144.1 13541.6 14258.6 14702.6 14828.0 9251.8 9324.4 9396.8 9403.2 9418.9 9847.0 9868.6 10496.9 14171.9 14328.4 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#3] mootools.html Cycles:180 Average:5162.43 Median:6180.16 stddev:2602.78 (42.1%) stddev-sans-first:2594.09 15:40:53 INFO - PROCESS | 8724 | Values: 1324.6 1484.7 1498.3 1658.7 1818.0 6467.9 7135.9 7281.3 7287.6 7291.7 7135.9 7292.7 7294.8 7296.7 7319.7 1976.4 2006.2 2175.7 2229.3 2262.4 2254.3 2265.8 2274.1 2274.2 2274.4 2155.9 2206.5 2215.0 2223.2 2230.6 2221.7 2227.1 2251.3 2251.9 2258.2 2268.0 2280.9 2307.4 2308.2 2314.4 7332.3 7418.9 7424.6 7432.6 7434.0 4423.1 4506.7 4509.4 4528.9 4535.0 2973.7 2995.6 3029.0 3035.0 3101.5 903.4 906.9 914.4 949.1 952.9 9990.4 10025.1 10040.2 10073.4 10083.5 4081.7 4085.4 4138.6 4163.1 4172.4 8566.7 8569.5 8578.7 8584.2 8586.3 4564.7 4565.3 4566.6 4568.4 4570.2 4105.0 4164.8 4165.5 4179.6 4180.4 3294.3 3329.0 3505.7 3511.1 3557.6 1131.8 1146.5 1149.4 1151.4 1157.8 1022.5 1031.0 1033.0 1161.8 1341.6 6835.8 6865.7 6914.0 6915.5 6928.5 1100.1 1105.2 1112.9 1117.8 1119.8 5518.3 5598.3 5601.1 5604.5 5605.6 8416.0 8477.7 8651.0 8651.8 8725.1 8439.2 8439.7 8458.4 8539.1 8541.4 6737.1 6760.2 6808.5 6826.6 6883.8 6893.5 6957.5 6968.3 6979.6 6987.1 7520.8 7692.2 7793.5 7870.1 7895.0 8030.7 8031.4 8182.9 8288.8 8298.2 6563.7 6639.6 6666.7 6705.4 6706.8 6231.9 6335.8 6780.4 6965.4 6975.7 6586.4 6628.1 6656.3 6766.9 6772.7 6515.2 6575.8 6606.1 6707.8 6768.6 6427.2 6467.1 6483.3 6488.8 6499.5 6110.1 6151.6 6208.7 6223.2 6223.3 6054.3 6122.1 6139.6 6145.2 6148.0 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#4] prototype.html Cycles:180 Average:5431.98 Median:6143.62 stddev:1661.76 (27.0%) stddev-sans-first:1621.74 15:40:53 INFO - PROCESS | 8724 | Values: 332.6 336.7 338.3 340.5 348.2 6102.7 6120.7 6131.8 6143.4 6143.9 5836.5 5927.7 5981.3 6013.8 6126.8 4684.0 4686.4 4686.5 4698.3 4706.5 4481.1 4699.6 4702.3 4706.3 4706.9 4506.3 4517.0 4608.1 4617.0 4636.3 4611.3 4627.2 4641.9 4642.4 4658.9 4079.9 4080.9 4084.9 4088.0 4099.8 5649.9 5790.2 5792.0 5802.5 5805.8 5366.8 5399.4 5402.9 5414.6 5432.5 6534.3 6537.9 6540.0 6540.4 6547.1 4476.3 4477.1 4478.4 4481.4 4484.7 6627.8 6738.1 6799.7 6805.0 6807.7 4432.2 4438.7 4444.0 4447.3 4448.5 4485.2 4500.9 4501.8 4507.8 4509.4 5265.2 5271.6 5273.0 5282.5 5295.8 6414.4 6535.9 6554.4 6556.6 6566.1 1617.1 1641.2 1643.4 1643.8 1644.7 1063.0 1075.3 1075.8 1085.0 1095.5 6198.9 6204.3 6204.9 6214.0 6214.9 6536.7 6765.1 6766.2 6766.3 6768.0 6110.3 6142.1 6207.5 6232.5 6238.5 3652.0 3663.4 3676.5 3682.0 3696.9 6872.9 6989.3 7038.8 7064.2 7077.8 6920.5 6923.8 6926.2 6932.8 6938.4 7000.3 7035.5 7043.8 7046.8 7047.2 6539.2 6703.6 6770.9 6771.9 6773.3 6624.7 6713.3 6721.0 6721.6 6728.3 7067.3 7076.3 7077.8 7085.2 7091.4 4446.5 4563.6 4608.9 4609.6 4612.1 6687.0 6694.8 6697.1 6741.5 6781.5 6587.4 6589.8 6593.2 6601.6 6605.9 6353.1 6549.9 6560.7 6586.6 6591.1 6423.8 6438.7 6439.6 6444.4 6445.9 6554.4 6578.3 6587.9 6590.0 6590.8 6238.0 6335.7 6360.8 6431.8 6436.8 15:40:53 INFO - PROCESS | 8724 | 15:40:53 INFO - PROCESS | 8724 | [#5] yui.html Cycles:180 Average:14145.95 Median:24141.63 stddev:16333.52 (67.7%) stddev-sans-first:16348.20 15:40:53 INFO - PROCESS | 8724 | Values: 716.5 721.3 798.2 837.6 868.7 13771.9 14009.4 14025.7 14034.8 14046.9 12638.4 13135.9 13227.5 13230.3 14509.3 826.3 842.2 842.8 842.9 843.4 835.2 835.6 837.8 840.3 842.6 864.5 870.6 871.7 872.6 873.1 870.0 871.1 871.1 871.7 873.2 643.9 644.5 644.6 644.7 645.0 12978.9 13590.3 13623.0 13673.9 13710.1 12745.9 12797.7 12978.1 13109.5 13334.3 10692.1 10764.2 10989.3 11176.9 11182.2 3639.7 3694.9 3762.0 3775.2 3846.8 41929.6 43878.8 44073.8 44206.3 49600.3 9932.7 10014.4 10151.3 10194.5 10292.7 17308.7 17398.6 17421.2 17424.9 17426.0 7913.7 8012.3 8018.0 8067.6 8164.6 4288.5 4404.5 4417.3 4449.2 4482.6 3099.8 3115.5 3121.5 3126.6 3133.1 585.6 586.8 591.9 595.9 613.0 648.6 664.3 682.1 685.4 688.9 8434.2 8779.9 8790.2 8849.5 8886.3 589.6 618.5 652.6 659.7 662.8 4103.8 4142.9 4179.8 4266.1 4324.8 59138.4 59500.7 60740.7 61025.7 61050.0 51288.7 51653.0 53094.2 53366.5 53963.5 42562.8 46854.8 50076.0 51927.0 52958.2 8345.2 8856.8 9082.4 9193.5 9235.4 28801.4 37958.0 38260.2 38433.0 39717.0 45148.2 46058.8 46091.0 46188.3 46896.0 11056.7 11435.3 11457.1 11585.0 11725.1 12383.6 12489.3 12563.7 12614.9 13068.3 11588.2 11712.7 11845.5 12127.8 12498.9 11334.2 11622.9 11673.4 11964.6 12337.5 11375.8 11542.7 11641.5 11653.1 11988.8 10064.1 10084.4 10388.7 10536.5 10574.3 9346.0 9767.3 10083.6 10170.1 10192.7 15:40:53 INFO - PROCESS | 8724 | -------- Summary: end -------- 15:40:53 INFO - PROCESS | 8724 | 15:40:54 INFO - TEST-INFO | 8724: exit 0 15:40:54 INFO - TEST-OK | dromaeo_css | took 1113630ms 15:40:54 INFO - TEST-START | kraken 15:40:54 INFO - operating with platform_type : linux_ 15:40:54 INFO - Initialising browser for kraken test... 15:40:54 INFO - TEST-INFO | started process 8915 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4w_xA3/profile http://localhost:50229/getInfo.html) 15:40:59 INFO - PROCESS | 8915 | __metrics Screen width/height:1600/1200 15:40:59 INFO - PROCESS | 8915 | colorDepth:24 15:40:59 INFO - PROCESS | 8915 | Browser inner width/height: 1024/697 15:40:59 INFO - PROCESS | 8915 | __metrics 15:40:59 INFO - PROCESS | 8915 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:40:59 INFO - PROCESS | 8915 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:00 INFO - TEST-INFO | 8915: exit 0 15:41:00 INFO - Browser initialized. 15:41:00 INFO - Running cycle 1/1 for kraken test... 15:41:00 INFO - TEST-INFO | started process 8998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4w_xA3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:11 INFO - PROCESS | 8998 | RSS: Main: 150347776 15:41:11 INFO - PROCESS | 8998 | 15:41:14 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50229/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:14 INFO - PROCESS | 8998 | RSS: Main: 185241600 15:41:14 INFO - PROCESS | 8998 | 15:41:17 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50229/tests/kraken/driver.html?testName=audio-dft) 15:41:18 INFO - PROCESS | 8998 | RSS: Main: 174415872 15:41:18 INFO - PROCESS | 8998 | 15:41:21 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50229/tests/kraken/driver.html?testName=audio-fft) 15:41:21 INFO - PROCESS | 8998 | RSS: Main: 159354880 15:41:21 INFO - PROCESS | 8998 | 15:41:23 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50229/tests/kraken/driver.html?testName=audio-oscillator) 15:41:24 INFO - PROCESS | 8998 | RSS: Main: 162299904 15:41:24 INFO - PROCESS | 8998 | 15:41:26 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:26 INFO - PROCESS | 8998 | RSS: Main: 165462016 15:41:26 INFO - PROCESS | 8998 | 15:41:29 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50229/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:30 INFO - PROCESS | 8998 | RSS: Main: 165244928 15:41:30 INFO - PROCESS | 8998 | 15:41:33 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50229/tests/kraken/driver.html?testName=imaging-desaturate) 15:41:34 INFO - PROCESS | 8998 | RSS: Main: 165158912 15:41:34 INFO - PROCESS | 8998 | 15:41:37 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50229/tests/kraken/driver.html?testName=json-parse-financial) 15:41:37 INFO - PROCESS | 8998 | RSS: Main: 164560896 15:41:37 INFO - PROCESS | 8998 | 15:41:39 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:41:39 INFO - PROCESS | 8998 | RSS: Main: 177750016 15:41:39 INFO - PROCESS | 8998 | 15:41:41 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:41:42 INFO - PROCESS | 8998 | RSS: Main: 175153152 15:41:42 INFO - PROCESS | 8998 | 15:41:44 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:41:44 INFO - PROCESS | 8998 | RSS: Main: 183754752 15:41:44 INFO - PROCESS | 8998 | 15:41:47 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:47 INFO - PROCESS | 8998 | RSS: Main: 193507328 15:41:47 INFO - PROCESS | 8998 | 15:41:50 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:41:51 INFO - PROCESS | 8998 | RSS: Main: 190341120 15:41:51 INFO - PROCESS | 8998 | 15:41:52 INFO - PROCESS | 8998 | Cycle 1(1): loaded http://localhost:50229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50229/tests/kraken/driver.html?testName=ai-astar) 15:41:53 INFO - PROCESS | 8998 | RSS: Main: 248692736 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | __start_tp_report 15:41:53 INFO - PROCESS | 8998 | _x_x_mozilla_page_load 15:41:53 INFO - PROCESS | 8998 | _x_x_mozilla_page_load_details 15:41:53 INFO - PROCESS | 8998 | |i|pagename|runs| 15:41:53 INFO - PROCESS | 8998 | |0;ai-astar;109;110;104;110;110;111;101;108;108;101 15:41:53 INFO - PROCESS | 8998 | |1;audio-beat-detection;155;124;153;158;126;149;151;128;165;133 15:41:53 INFO - PROCESS | 8998 | |2;audio-dft;162;160;160;160;161;161;161;164;161;160 15:41:53 INFO - PROCESS | 8998 | |3;audio-fft;71;71;79;95;72;72;73;118;89;71 15:41:53 INFO - PROCESS | 8998 | |4;audio-oscillator;96;96;135;96;97;96;141;97;96;135 15:41:53 INFO - PROCESS | 8998 | |5;imaging-gaussian-blur;109;110;109;110;109;109;109;109;110;109 15:41:53 INFO - PROCESS | 8998 | |6;imaging-darkroom;145;146;145;146;146;145;146;145;145;145 15:41:53 INFO - PROCESS | 8998 | |7;imaging-desaturate;96;96;96;96;96;95;95;96;103;95 15:41:53 INFO - PROCESS | 8998 | |8;json-parse-financial;57;57;58;57;58;56;58;66;56;58 15:41:53 INFO - PROCESS | 8998 | |9;json-stringify-tinderbox;67;67;68;67;68;68;68;67;68;68 15:41:53 INFO - PROCESS | 8998 | |10;stanford-crypto-aes;84;94;87;88;89;85;87;86;87;87 15:41:53 INFO - PROCESS | 8998 | |11;stanford-crypto-ccm;113;131;122;118;111;114;120;116;122;122 15:41:53 INFO - PROCESS | 8998 | |12;stanford-crypto-pbkdf2;143;146;154;151;152;141;152;150;151;146 15:41:53 INFO - PROCESS | 8998 | |13;stanford-crypto-sha256-iterative;67;68;68;66;66;73;67;68;69;66 15:41:53 INFO - PROCESS | 8998 | __end_tp_report 15:41:53 INFO - PROCESS | 8998 | __start_cc_report 15:41:53 INFO - PROCESS | 8998 | _x_x_mozilla_cycle_collect,934 15:41:53 INFO - PROCESS | 8998 | __end_cc_report 15:41:53 INFO - PROCESS | 8998 | __startTimestamp1451346113036__endTimestamp 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | ------- Summary: start ------- 15:41:53 INFO - PROCESS | 8998 | Number of tests: 14 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.50 stddev:3.79 (3.5%) stddev-sans-first:3.97 15:41:53 INFO - PROCESS | 8998 | Values: 109.0 110.0 104.0 110.0 110.0 111.0 101.0 108.0 108.0 101.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:152.00 stddev:14.96 (9.8%) stddev-sans-first:15.35 15:41:53 INFO - PROCESS | 8998 | Values: 155.0 124.0 153.0 158.0 126.0 149.0 151.0 128.0 165.0 133.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 15:41:53 INFO - PROCESS | 8998 | Values: 162.0 160.0 160.0 160.0 161.0 161.0 161.0 164.0 161.0 160.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#3] audio-fft Cycles:10 Average:81.10 Median:72.50 stddev:15.49 (21.4%) stddev-sans-first:15.99 15:41:53 INFO - PROCESS | 8998 | Values: 71.0 71.0 79.0 95.0 72.0 72.0 73.0 118.0 89.0 71.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:96.00 stddev:19.74 (20.6%) stddev-sans-first:20.41 15:41:53 INFO - PROCESS | 8998 | Values: 96.0 96.0 135.0 96.0 97.0 96.0 141.0 97.0 96.0 135.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:41:53 INFO - PROCESS | 8998 | Values: 109.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:41:53 INFO - PROCESS | 8998 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:2.37 (2.5%) stddev-sans-first:2.51 15:41:53 INFO - PROCESS | 8998 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 103.0 95.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.88 (5.0%) stddev-sans-first:3.03 15:41:53 INFO - PROCESS | 8998 | Values: 57.0 57.0 58.0 57.0 58.0 56.0 58.0 66.0 56.0 58.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 15:41:53 INFO - PROCESS | 8998 | Values: 67.0 67.0 68.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.72 (3.1%) stddev-sans-first:2.59 15:41:53 INFO - PROCESS | 8998 | Values: 84.0 94.0 87.0 88.0 89.0 85.0 87.0 86.0 87.0 87.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:121.00 stddev:5.84 (4.8%) stddev-sans-first:5.79 15:41:53 INFO - PROCESS | 8998 | Values: 113.0 131.0 122.0 118.0 111.0 114.0 120.0 116.0 122.0 122.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:151.00 stddev:4.33 (2.9%) stddev-sans-first:4.09 15:41:53 INFO - PROCESS | 8998 | Values: 143.0 146.0 154.0 151.0 152.0 141.0 152.0 150.0 151.0 146.0 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - PROCESS | 8998 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:2.10 (3.1%) stddev-sans-first:2.20 15:41:53 INFO - PROCESS | 8998 | Values: 67.0 68.0 68.0 66.0 66.0 73.0 67.0 68.0 69.0 66.0 15:41:53 INFO - PROCESS | 8998 | -------- Summary: end -------- 15:41:53 INFO - PROCESS | 8998 | 15:41:53 INFO - TEST-INFO | 8998: exit 0 15:41:53 INFO - TEST-OK | kraken | took 59311ms 15:41:53 INFO - TEST-START | v8_7 15:41:53 INFO - operating with platform_type : linux_ 15:41:53 INFO - Initialising browser for v8_7 test... 15:41:53 INFO - TEST-INFO | started process 9250 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzWpODo/profile http://localhost:50229/getInfo.html) 15:41:58 INFO - PROCESS | 9250 | __metrics Screen width/height:1600/1200 15:41:58 INFO - PROCESS | 9250 | colorDepth:24 15:41:58 INFO - PROCESS | 9250 | Browser inner width/height: 1024/697 15:41:58 INFO - PROCESS | 9250 | __metrics 15:41:58 INFO - PROCESS | 9250 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:41:58 INFO - PROCESS | 9250 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:59 INFO - TEST-INFO | 9250: exit 0 15:41:59 INFO - Browser initialized. 15:41:59 INFO - Running cycle 1/1 for v8_7 test... 15:41:59 INFO - TEST-INFO | started process 9329 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzWpODo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:11 INFO - PROCESS | 9329 | RSS: Main: 148340736 15:42:11 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | Cycle 1(1): loaded http://localhost:50229/tests/v8_7/run.html (next: http://localhost:50229/tests/v8_7/run.html) 15:42:32 INFO - PROCESS | 9329 | RSS: Main: 545275904 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | __start_tp_report 15:42:32 INFO - PROCESS | 9329 | _x_x_mozilla_page_load 15:42:32 INFO - PROCESS | 9329 | _x_x_mozilla_page_load_details 15:42:32 INFO - PROCESS | 9329 | |i|pagename|runs| 15:42:32 INFO - PROCESS | 9329 | |0;Richards;167.44809109176154 15:42:32 INFO - PROCESS | 9329 | |1;DeltaBlue;191.2411550965768 15:42:32 INFO - PROCESS | 9329 | |2;Encrypt;279.79854504756577 15:42:32 INFO - PROCESS | 9329 | |3;Decrypt;5175.257731958763 15:42:32 INFO - PROCESS | 9329 | |4;RayTrace;1968.5039370078741 15:42:32 INFO - PROCESS | 9329 | |5;Earley;774.5933384972889 15:42:32 INFO - PROCESS | 9329 | |6;Boyer;12243.90243902439 15:42:32 INFO - PROCESS | 9329 | |7;RegExp;25100 15:42:32 INFO - PROCESS | 9329 | |8;Splay;565.4862282181001 15:42:32 INFO - PROCESS | 9329 | |9;NavierStokes;4826.923076923077 15:42:32 INFO - PROCESS | 9329 | __end_tp_report 15:42:32 INFO - PROCESS | 9329 | __startTimestamp1451346152918__endTimestamp 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | ------- Summary: start ------- 15:42:32 INFO - PROCESS | 9329 | Number of tests: 10 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#0] Richards Cycles:1 Average:167.45 Median:167.45 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 167.4 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#1] DeltaBlue Cycles:1 Average:191.24 Median:191.24 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 191.2 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 279.8 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 5175.3 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 1968.5 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#5] Earley Cycles:1 Average:774.59 Median:774.59 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 774.6 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 12243.9 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 25100.0 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#8] Splay Cycles:1 Average:565.49 Median:565.49 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 565.5 15:42:32 INFO - PROCESS | 9329 | 15:42:32 INFO - PROCESS | 9329 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 15:42:32 INFO - PROCESS | 9329 | Values: 4826.9 15:42:32 INFO - PROCESS | 9329 | -------- Summary: end -------- 15:42:32 INFO - PROCESS | 9329 | 15:42:33 INFO - TEST-INFO | 9329: exit 0 15:42:33 INFO - TEST-OK | v8_7 | took 39830ms 15:42:33 INFO - SUITE-END | took 1212s 15:42:33 INFO - Completed test suite (00:20:12) 15:42:33 INFO - Working with test: dromaeo_css 15:42:33 INFO - Generating results file: dromaeo_css 15:42:33 INFO - Working with test: kraken 15:42:33 INFO - Generating results file: kraken 15:42:33 INFO - javascript benchmark 15:42:33 INFO - Working with test: v8_7 15:42:33 INFO - Generating results file: v8_7 15:42:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:42:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 15:42:33 INFO - process_Request line: dromaeo_css 7009.02 graph.html#tests=[[72,201,35]] 15:42:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:42:33 INFO - process_Request line: kraken 1501.50 graph.html#tests=[[232,201,35]] 15:42:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:42:34 INFO - process_Request line: v8_7 20046.89 graph.html#tests=[[230,201,35]] 15:42:34 INFO - RETURN: dromaeo_css: 7009.02 15:42:34 INFO - RETURN: kraken: 1501.50 15:42:34 INFO - RETURN: v8_7: 20046.89 15:42:34 INFO - javascript benchmark 15:42:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.9684503154967, 3200.951985720213, 3229.5963004624423, 3233.8059716417, 3259.006003169033, 5152.768125434355, 5265.420803711589, 5323.0, 5339.546138578221, 5356.250124982505, 5353.946460535393, 5357.812476563321, 5407.405185429599, 5415.0523658359825, 5418.024755544, 4818.59041981432, 4854.660173787827, 4943.492234868364, 5039.470855560168, 5061.645684802065, 4798.0643774464, 4958.157113290749, 4982.352294201749, 5027.874303142414, 5055.949440505603, 4819.108464933981, 4910.508949105097, 4959.603231741488, 4993.925091123636, 5041.798328066873, 4868.599470523671, 4875.731834749123, 4882.0, 4882.218844984821, 4925.187344088221, 4803.687760295605, 4848.127337079324, 4851.442084160331, 4884.511548845123, 4918.877028074291, 5087.847364579068, 5098.260752190911, 5186.818461353872, 5189.091908915962, 5213.061648903196, 5678.517326027292, 5683.971580142114, 5688.800891968803, 5689.231953686282, 5712.971435142797, 5693.259876216107, 5694.6867922264255, 5697.430256974311, 5702.800401985911, 5705.5720820938595, 5344.22508736235, 5356.464353564613, 5438.483344082306, 5440.183972404131, 5455.8090466834265, 5915.852103697442, 5916.526677865761, 5939.881202375928, 5970.0746384310505, 5977.462028417463, 5674.546036317085, 5713.771449141987, 5717.685527295956, 5729.312482502127, 5751.424857514216, 5713.628614140068, 5743.655380677089, 5750.223719797774, 5815.214945982323, 5889.734961926723, 5648.181013752983, 5665.263515742927, 5673.262475878109, 5686.061799803069, 5706.828795136153, 5653.378128405872, 5662.915056274159, 5663.292088488939, 5670.489655930986, 5672.574556908248, 4271.188474189956, 4356.019895523482, 4400.0, 4435.822567097344, 4465.553444655573, 3922.235164143022, 3936.5079365079364, 3960.6237407446247, 3973.324534829086, 3974.8012599370495, 5294.523492885659, 5302.019126461617, 5308.46915308466, 5315.760790764425, 5351.678899266057, 5568.470995255444, 5685.005124103348, 5694.231278777312, 5728.0, 5767.307923049261, 5310.787568497294, 5328.440513746078, 5351.491608297206, 5351.705656188869, 5371.62398632092, 4956.4547899731, 4971.527704868032, 4975.950240497621, 4985.351904252424, 5033.7734801934, 5702.315722113373, 5811.88376232473, 5813.680247586423, 5859.765609375662, 5890.528757699288, 5736.282964629421, 5739.0, 5756.740946657326, 5763.452472015152, 5798.507126894261, 5877.35349111606, 5882.323532793784, 5883.735231914659, 5888.0, 5898.734556945034, 5505.091659876236, 5573.108302671553, 5579.079451890392, 5630.634008789416, 5679.006173919465, 5678.0915053591225, 5720.08478643415, 5729.770809167587, 5775.971120144372, 5816.621919575214, 5568.359638641608, 5572.0527510324155, 5574.052411090043, 5574.442555744393, 5580.441955804549, 5496.862578435571, 5526.751296191601, 5560.2493663356545, 5582.218489411567, 5611.859703507282, 5478.643888147258, 5483.0, 5532.944670553243, 5545.750441230073, 5595.496405323541, 5550.139728342114, 5599.32808063035, 5601.719914004365, 5604.131359639263, 5659.462351076641, 5401.081816091352, 5454.372747134131, 5494.945050549443, 5497.312835895513, 5500.147477141049], "unit": "score", "name": "dojo.html", "value": 5279.305514019754}, {"lowerIsBetter": false, "replicates": [525.2961032216829, 533.4665334665335, 570.4352690836072, 576.7721749908785, 579.5132089045201, 28317.433651326963, 28958.710412895864, 35363.64636353639, 35879.0, 35910.10224744383, 39536.40695389564, 39950.80024599873, 39955.60044399555, 40000.599994000055, 40031.0, 7376.815579610526, 8516.8722469163, 8681.262092722127, 8681.609327580274, 8696.34777391695, 7465.962670186642, 10186.388816670986, 10389.948050259738, 10413.427261500614, 10432.0, 10113.393196408239, 10121.139703125207, 10135.49322533874, 10220.642277520288, 10225.0, 7573.734919277799, 7732.845343093107, 9911.207103431745, 9957.850632240523, 10268.332558383681, 9903.752406189831, 9927.652532161339, 9976.650817221362, 10038.749031274203, 10046.346987445793, 36522.086947826254, 36910.26179476422, 36920.70777522774, 37202.0, 37267.62732372669, 3110.440120778259, 3183.554302397666, 3242.8054316741072, 3932.941005884914, 4153.293940030172, 28931.710682893114, 29218.853905730546, 29327.12018639444, 29350.559741603895, 31336.529952050736, 3786.2048969716393, 3971.721979461439, 3982.780947047911, 4039.434479172918, 4162.6253637172495, 217218.0, 218474.0, 218738.0, 218817.0, 218915.0, 55535.444645553835, 55596.72201639047, 55846.0, 55899.441005589426, 55964.72017639967, 58999.0, 59144.40855591475, 59147.40852591419, 59159.704201478715, 64346.0, 13963.79054314186, 14131.576052718436, 14132.505362312475, 14138.575842724735, 14142.151470911573, 10625.415602141957, 10689.144868410509, 10689.9465502672, 10694.358338499715, 10704.0, 19473.8052619472, 20409.48976275605, 20425.38723838287, 20612.58774824495, 20678.689819652718, 6752.0, 7885.369170466349, 8038.196180381915, 8113.5131892086665, 8350.582470876432, 933.1927882381826, 959.5010594490826, 980.9117179453883, 1044.5612842606124, 1122.320995797547, 27627.585586216224, 28725.56911646327, 28978.855105724335, 29034.716928833393, 29103.708962910525, 1055.889131641182, 1126.0709914320719, 1145.8395824584566, 1147.8794726553758, 1180.7579446213676, 14165.291735413188, 14877.925610371878, 14951.626209344637, 15292.923535382251, 15346.693066138614, 247748.0, 252309.0, 252332.0, 252338.0, 252611.0, 48402.27396589054, 48873.51126488761, 48911.26633100506, 48951.265731014064, 49133.50866491361, 1346.0981142634262, 1373.5604606526015, 1380.151207007683, 1387.8681525255286, 1392.394308475796, 26838.731612683623, 27920.720792791813, 29567.852160739058, 29589.112326630235, 30022.69977300199, 50154.49845501498, 51294.74352628213, 51362.0, 51373.22940155826, 51388.48611513837, 241793.0, 247403.0, 247496.0, 247637.0, 248033.0, 37366.62633373631, 38027.80986095052, 43744.343834841864, 43869.78065109782, 44414.77792611016, 39912.0, 40388.394174086825, 40658.79670601628, 40696.3895541573, 41086.794566026976, 34000.0, 35296.0, 37757.244855102195, 37774.811125944194, 38949.0, 33419.331613368086, 34471.9339985798, 34565.30869382648, 36877.26245475129, 37169.25661486701, 36513.45229821608, 36973.81513092525, 37151.6284837159, 37426.0, 37652.623473764914, 31211.0, 32921.0, 33205.0, 33237.50143747894, 33282.66717332796, 24838.254852354457, 25102.497950041263, 25569.360765980255, 25621.34830342269, 25737.227883163534], "unit": "score", "name": "ext.html", "value": 18338.87021991726}, {"lowerIsBetter": false, "replicates": [351.53772788782766, 360.49170669356215, 360.61594401961906, 365.1929236387583, 365.2895118993557, 14108.929455352734, 14174.645633859158, 16407.0, 16765.0, 17444.389446369365, 16446.177691115427, 16529.50411487654, 16816.57958551034, 16830.410935617227, 16869.07220102897, 5379.919301210475, 5496.725163741817, 5512.145617429305, 5513.035218836708, 5515.0, 4024.859129930453, 4142.937855932163, 5451.918221226685, 5513.862153446176, 5803.941960580382, 5874.060150375941, 5898.911516327258, 5911.911321330162, 5919.970400147993, 5926.081457374093, 5656.604037717361, 5856.414358564152, 5860.853478663067, 5865.648061116347, 5873.823785286449, 5078.720670363128, 5093.414257360414, 5134.563562097226, 5138.897222055538, 5161.61287903405, 19382.70925936112, 20129.698054529195, 20151.697724534144, 20576.0, 20954.476138096517, 2089.686547017944, 2171.0989939175383, 2190.452386903274, 2262.242148880127, 2747.079728291025, 13115.344232788322, 13174.143680660822, 13175.209487430784, 13579.321033948361, 13652.317384130754, 1804.3684710351404, 1815.174095786414, 1831.0753069699717, 1897.5256185953513, 1898.4209816006112, 57455.42544574542, 60345.0, 60594.09108863371, 60966.0, 61058.694706526185, 9325.860112098324, 9413.435193888388, 9593.328467007243, 9595.088466595662, 9633.807323853483, 12478.937605311916, 12493.562725304571, 12499.812502812465, 12500.24998500093, 12573.057020723483, 7229.674664639999, 7236.204017558064, 7261.745838895613, 7383.409327253807, 7458.962705186548, 7191.137063552407, 7210.2789721027475, 7226.168990566047, 7226.205117437078, 7280.017197678351, 5777.653340799566, 5787.276590426197, 5792.768289268466, 5855.0, 5950.434708702666, 1645.7120003999253, 1721.3544920654754, 1725.7402096469395, 1750.2561411400104, 1764.8941063536229, 921.6543796076471, 925.4817302310728, 950.9619615215453, 997.9072915157891, 1043.4991204221865, 16026.278817453243, 16115.758263626056, 16585.419510317322, 16820.74768878468, 16876.15619219034, 846.530175752451, 885.1526764742242, 892.9107089291149, 901.2699713232303, 996.566493575297, 9610.759731006641, 9760.316777825485, 10274.640387586398, 10281.383117012854, 10387.636432724817, 567961.0, 576449.0, 591048.0, 591325.0, 596282.0185899129, 71004.93492597615, 72856.63571682214, 73540.63229683817, 76544.23455765483, 83263.5836820812, 1156.9247998880214, 1160.7678464307342, 1204.9638510844688, 1219.9451024703733, 1227.4844565282604, 14679.266036697909, 15219.543413697607, 15539.922300388425, 15688.529344119695, 16281.267342969832, 35141.824290879405, 35411.645883540834, 36620.26759464849, 36670.266594668494, 36688.0, 48208.276875847594, 48355.5164448351, 48850.022999540524, 48894.75552622214, 49321.50678493169, 9352.766180845534, 9641.42151470914, 10059.19526437898, 10100.090991810772, 10164.593416263267, 17399.913000434917, 17594.560135996704, 17790.37733679315, 17807.554811129306, 18098.366557170437, 14472.927635362177, 14581.489647862274, 14772.926135369255, 14816.185109819064, 15215.391384344503, 14281.857181428053, 14343.0, 14502.0, 14558.4904528341, 14823.036502627294, 12144.14990950625, 13541.59375218745, 14258.572242832732, 14702.632434188803, 14828.0, 9251.814963700823, 9324.393914395543, 9396.812063758549, 9403.153716165578, 9418.858717119112, 9846.950765246127, 9868.605255789687, 10496.947515262375, 14171.893541277952, 14328.355224015153], "unit": "score", "name": "jquery.html", "value": 9014.128880967906}, {"lowerIsBetter": false, "replicates": [1324.5628942448993, 1484.6511069898575, 1498.258362110755, 1658.6599747051855, 1818.0455260987972, 6467.870642587145, 7135.85728285434, 7281.308275713805, 7287.635618219095, 7291.7447889323885, 7135.89296160558, 7292.7447539336135, 7294.817629559264, 7296.70813167474, 7319.7438089666875, 1976.3873199308189, 2006.167440512193, 2175.673648952654, 2229.308914236584, 2262.4457008033055, 2254.256095488493, 2265.762094980028, 2274.090363854455, 2274.2040285899966, 2274.431392151962, 2155.892205389732, 2206.5145667953107, 2215.0364591402713, 2223.2218723446745, 2230.587341341857, 2221.6556433752794, 2227.13141874669, 2251.2908433843368, 2251.864888106719, 2258.153192552793, 2267.977320226793, 2280.8631482111127, 2307.3654744945106, 2308.2382813671616, 2314.351981445198, 7332.30343117403, 7418.851622967564, 7424.628768561551, 7432.554046757212, 7434.033575635187, 4423.1153769246275, 4506.7070640408265, 4509.368688383629, 4528.8641340759505, 4535.024969631512, 2973.717496837797, 2995.6405231372155, 3028.9848550757106, 3035.043961152252, 3101.5037593984853, 903.4308385716956, 906.8775715278418, 914.401067300919, 949.1125797379403, 952.9285303602188, 9990.35062720928, 10025.097741203253, 10040.246981476419, 10073.395596264247, 10083.495825208784, 4081.69387295954, 4085.3667681509414, 4138.6482149017065, 4163.084121493267, 4172.374143878443, 8566.700165494178, 8569.528675922884, 8578.656853725906, 8584.184502472255, 8586.270167035747, 4564.748938808398, 4565.292379681155, 4566.589006989387, 4568.383268258809, 4570.223062079454, 4104.979475102665, 4164.770937598461, 4165.520965089054, 4179.6029377209115, 4180.352045432963, 3294.3081952789703, 3329.034579971781, 3505.6669616386403, 3511.122219445139, 3557.626449222846, 1131.7906187355366, 1146.507001989136, 1149.4425203776161, 1151.3725019864194, 1157.774234024374, 1022.4632068164125, 1031.03083101884, 1033.0341131042499, 1161.8257261410856, 1341.5706973768495, 6835.760748373783, 6865.656717164122, 6914.032035515032, 6915.51591388608, 6928.4803639726215, 1100.0759362135843, 1105.1932089574655, 1112.9109671226283, 1117.7764447110449, 1119.8488204092507, 5518.2826232590305, 5598.300212473441, 5601.075822489243, 5604.467575580314, 5605.5795815313195, 8415.95792021036, 8477.660893564189, 8650.95674521636, 8651.783705407415, 8725.127487251224, 8439.198276163877, 8439.70461033861, 8458.407911446262, 8539.14608539141, 8541.444806087584, 6737.124173857465, 6760.1549806274215, 6808.489363297674, 6826.556273842284, 6883.7590684325805, 6893.482988775761, 6957.478189135936, 6968.268331825288, 6979.616121113185, 6987.091678081817, 7520.811979700551, 7692.153863074946, 7793.532388056735, 7870.134285228734, 7895.0, 8030.718924837603, 8031.357491400557, 8182.918170818216, 8288.792780180302, 8298.170182981896, 6563.671816409065, 6639.601623902581, 6666.666666666551, 6705.362990516089, 6706.83232919181, 6231.937680623136, 6335.827871843724, 6780.423663988616, 6965.407940325129, 6975.7209711612995, 6586.37429444202, 6628.105205797348, 6656.334366563498, 6766.8646627068165, 6772.7290908365085, 6515.218173818982, 6575.835604109936, 6606.075149478981, 6707.8323041922395, 6768.56004359715, 6427.228732552124, 6467.126937863516, 6483.319251478715, 6488.805335839932, 6499.545031847725, 6110.144579758926, 6151.630902145886, 6208.689565521796, 6223.159873417212, 6223.3465486123305, 6054.273487181566, 6122.112293717297, 6139.570230083851, 6145.231846019247, 6147.96926015385], "unit": "score", "name": "mootools.html", "value": 4282.801817227535}, {"lowerIsBetter": false, "replicates": [332.5992179423795, 336.7322978232305, 338.32335329341316, 340.48926610084874, 348.1869833937755, 6102.694865256742, 6120.69396530174, 6131.834951359238, 6143.354947730485, 6143.877122457559, 5836.503897168735, 5927.673977931223, 5981.252343457068, 6013.789517366893, 6126.7855625053135, 4683.976580117094, 4686.437627484698, 4686.46105697844, 4698.295255711637, 4706.458757242926, 4481.148581769454, 4699.577038066574, 4702.318163866237, 4706.3411122442885, 4706.929396059062, 4506.346579745935, 4516.954830451687, 4608.1474927138415, 4616.97691511542, 4636.281376386665, 4611.262198048313, 4627.167109920213, 4641.930371044403, 4642.396488456513, 4658.86023419298, 4079.8572049978407, 4080.9387859182134, 4084.8570300039355, 4087.976451656419, 4099.815508302134, 5649.943500565024, 5790.189373487715, 5792.044312688401, 5802.535797136219, 5805.796797112081, 5366.812161574326, 5399.406065332811, 5402.8919421611745, 5414.593905457106, 5432.456754324576, 6534.281229064799, 6537.869242615121, 6539.9673001635165, 6540.4440622547145, 6547.148870646785, 4476.328550717386, 4477.059817438342, 4478.41780568524, 4481.417415735966, 4484.730916145042, 6627.768028118992, 6738.056672065914, 6799.7280108796085, 6805.047293378931, 6807.693653785592, 4432.246518091933, 4438.667099967515, 4444.044530425974, 4447.310666846644, 4448.510663826976, 4485.237509623306, 4500.929572396734, 4501.7974191161475, 4507.797149128297, 4509.436320459942, 5265.21021846726, 5271.551918087006, 5273.0, 5282.498162674539, 5295.841124766263, 6414.358564143642, 6535.8692826143215, 6554.377334153248, 6556.5738227016045, 6566.146400967844, 1617.102508107988, 1641.2204203003478, 1643.3919449803411, 1643.8109617393914, 1644.6792875389424, 1062.9893701063045, 1075.2688172043086, 1075.8493810866485, 1084.978300433987, 1095.46322302073, 6198.938010619836, 6204.317525072239, 6204.906926396107, 6214.0, 6214.875702485925, 6536.705848236841, 6765.086713293741, 6766.188057433041, 6766.25571187169, 6768.018637297564, 6110.327863934964, 6142.109394137825, 6207.534434917309, 6232.501399887998, 6238.469730072995, 3651.9634803652157, 3663.432168013962, 3676.540432445944, 3682.0, 3696.926061478809, 6872.862542749117, 6989.33601307875, 7038.753643622551, 7064.1876184238445, 7077.82305442368, 6920.515563910478, 6923.792286231421, 6926.238113807477, 6932.757353492704, 6938.444924406035, 7000.334968178015, 7035.542689725152, 7043.7534686285735, 7046.788596342016, 7047.189573199045, 6539.21529416454, 6703.631300278336, 6770.93229067703, 6771.898421523582, 6773.288804675438, 6624.701888415129, 6713.328667133248, 6721.0, 6721.596704197764, 6728.293529179561, 7067.328603782633, 7076.2923707628825, 7077.787666370017, 7085.185203701641, 7091.361777440055, 4446.488653804854, 4563.612092972002, 4608.930866036945, 4609.631229501699, 4612.100640375094, 6687.0, 6694.83262918431, 6697.129373181455, 6741.52809303344, 6781.457483401415, 6587.374199451045, 6589.80230593083, 6593.175853018372, 6601.570897891622, 6605.900911486236, 6353.078803573549, 6549.901751473827, 6560.704768285344, 6586.637734924433, 6591.110200123114, 6423.8394040147505, 6438.710258038306, 6439.613623182624, 6444.387783160592, 6445.871082578416, 6554.442872355903, 6578.309277525791, 6587.868242635024, 6590.044443555754, 6590.80227593173, 6237.96881015592, 6335.683215839097, 6360.840978975378, 6431.774887878902, 6436.8390790230615], "unit": "score", "name": "prototype.html", "value": 4889.67956157044}, {"lowerIsBetter": false, "replicates": [716.4948711158637, 721.3003386714885, 798.1858504325588, 837.6230696186716, 868.6655637579532, 13771.862281377184, 14009.369578368973, 14025.719485610281, 14034.789478157836, 14046.859531404683, 12638.368081595907, 13135.868641313584, 13227.470901163942, 13230.338483075855, 14509.274536273197, 826.2852632472913, 842.1999100854182, 842.7556008757452, 842.9494230346199, 843.3632607381419, 835.2274146414572, 835.5905606252923, 837.8491871463134, 840.2731637133896, 842.5744998775609, 864.4683519635441, 870.6386849457467, 871.6949067826242, 872.5637181409295, 873.1137895036543, 869.9608517616691, 871.0766587417357, 871.1245198575423, 871.6731225790329, 873.2228316798055, 643.9227292724856, 644.5455953552735, 644.6067898581862, 644.6969924135649, 645.0227904724346, 12978.935105324508, 13590.25253611051, 13623.04638675293, 13673.863261367458, 13710.108842925278, 12745.87254127456, 12797.680057998532, 12978.091533592653, 13109.47562097515, 13334.33328333589, 10692.144628429707, 10764.192685548614, 10989.285696429786, 11176.888231117748, 11182.217244792868, 3639.6906262967677, 3694.8891533253777, 3761.9811900940595, 3775.1505911170043, 3846.807659617008, 41929.58070419287, 43878.78060609708, 44073.77963110164, 44206.33690494613, 49600.255996160085, 9932.702018939442, 10014.39913605186, 10151.289409741246, 10194.541245643964, 10292.742681433025, 17308.65382692339, 17398.56503587395, 17421.216045277994, 17424.91287543554, 17426.0, 7913.683452661944, 8012.278894899487, 8018.0, 8067.556284404297, 8164.591770411455, 4288.549702281278, 4404.471463424409, 4417.337399390117, 4449.1991441540185, 4482.551744825557, 3099.8450077496036, 3115.470370037099, 3121.547375630521, 3126.6248050234117, 3133.075742655922, 585.5813093638069, 586.8092869817326, 591.8668299632549, 595.8867815115115, 613.0283500651517, 648.6034103985821, 664.3356643356643, 682.1098466501164, 685.3797313431353, 688.9321551595008, 8434.240918317259, 8779.912200877909, 8790.164934331227, 8849.51327676984, 8886.289096872235, 589.6344266554763, 618.4742968476759, 652.5725649699455, 659.7064306383613, 662.7879078694772, 4103.753774773523, 4142.855000075043, 4179.791010449465, 4266.1254442839145, 4324.827006919751, 59138.40861591415, 59500.70249648724, 60740.69629651912, 61025.69487152536, 61050.0, 51288.74355628198, 51653.0, 53094.20358694623, 53366.466335336925, 53963.460365396626, 42562.78718606387, 46854.765726171834, 50075.9984800302, 51927.0, 52958.205626915624, 8345.165483451849, 8856.822863542822, 9082.36423450352, 9193.54032298369, 9235.399699019543, 28801.42397152087, 37957.999999998894, 38260.23479530338, 38433.0, 39717.0, 45148.19407223674, 46058.76970615125, 46091.0, 46188.30717539307, 46896.0, 11056.723581910517, 11435.313881167156, 11457.140714446616, 11585.0, 11725.061995040547, 12383.62849114528, 12489.31308778026, 12563.685907852012, 12614.936925315315, 13068.346582671018, 11588.246763960316, 11712.70718232051, 11845.526178952745, 12127.81808272859, 12498.937505312415, 11334.206605537533, 11622.94188529052, 11673.357965311989, 11964.581239656918, 12337.50649973991, 11375.829362559734, 11542.653720388402, 11641.47613357384, 11653.126015548698, 11988.76022479528, 10064.144547713233, 10084.445355505517, 10388.731946047259, 10536.473176341306, 10574.2598018138, 9345.953270233606, 9767.316287859781, 10083.647072352433, 10170.135538479017, 10192.745181370525], "unit": "score", "name": "yui.html", "value": 6486.675168636372}], "name": "dromaeo_css", "value": 7009.018341082002}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 111.0, 101.0, 108.0, 108.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 153.0, 158.0, 126.0, 149.0, 151.0, 128.0, 165.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 164.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 79.0, 95.0, 72.0, 72.0, 73.0, 118.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 135.0, 96.0, 97.0, 96.0, 141.0, 97.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 103.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 56.0, 58.0, 66.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 94.0, 87.0, 88.0, 89.0, 85.0, 87.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [113.0, 131.0, 122.0, 118.0, 111.0, 114.0, 120.0, 116.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [143.0, 146.0, 154.0, 151.0, 152.0, 141.0, 152.0, 150.0, 151.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 73.0, 67.0, 68.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1501.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.44809109176154], "unit": "score", "name": "Richards", "value": 210.82354399999997}, {"lowerIsBetter": false, "replicates": [191.2411550965768], "unit": "score", "name": "DeltaBlue", "value": 345.7310220000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [774.5933384972889], "unit": "score", "name": "Earley", "value": 860.4037330000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [565.4862282181001], "unit": "score", "name": "Splay", "value": 144.10784194831012}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20046.893207854962}]} 15:42:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20046.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7009.02"}}} 15:42:34 INFO - Return code: 0 15:42:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:42:34 INFO - # TBPL SUCCESS # 15:42:34 INFO - Running post-action listener: _resource_record_post_action 15:42:34 INFO - Running post-run listener: _resource_record_post_run 15:42:35 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 73728; Write bytes: 567046144; Read time: 28; Write time: 538684 15:42:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246534144; Read time: 0; Write time: 353820 15:42:35 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 73728; Write bytes: 320208896; Read time: 28; Write time: 184832 15:42:35 INFO - Running post-run listener: _upload_blobber_files 15:42:35 INFO - Blob upload gear active. 15:42:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:42:35 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 15:42:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:42:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:42:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:36 INFO - (blobuploader) - INFO - Done attempting. 15:42:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:37 INFO - (blobuploader) - INFO - Done attempting. 15:42:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:37 INFO - Return code: 0 15:42:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:42:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55b9849f29b787317df7d35f26ae8e5c87a18576dd3fd72586b39cd64ed08c1a59c1de792d5a719ff03ab91d04957918a7f390ee3fa893bcceb8b6634fa5c25e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/343fa00612f2abd6d94599ce590d215fe8f295746f780b2262cad5adb9af97d9dd724aea9850a496007ef191dab8600456def342f35d1329966c8f0fea5853d5"} 15:42:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:42:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:42:37 INFO - Contents: 15:42:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55b9849f29b787317df7d35f26ae8e5c87a18576dd3fd72586b39cd64ed08c1a59c1de792d5a719ff03ab91d04957918a7f390ee3fa893bcceb8b6634fa5c25e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/343fa00612f2abd6d94599ce590d215fe8f295746f780b2262cad5adb9af97d9dd724aea9850a496007ef191dab8600456def342f35d1329966c8f0fea5853d5"} 15:42:37 INFO - Copying logs to upload dir... 15:42:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.410929 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-28 15:42:37.145487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 15:42:37.149526) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55b9849f29b787317df7d35f26ae8e5c87a18576dd3fd72586b39cd64ed08c1a59c1de792d5a719ff03ab91d04957918a7f390ee3fa893bcceb8b6634fa5c25e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/343fa00612f2abd6d94599ce590d215fe8f295746f780b2262cad5adb9af97d9dd724aea9850a496007ef191dab8600456def342f35d1329966c8f0fea5853d5"} build_url:https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/2I-_ZWQCQ1-zZtBjptSE4Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/55b9849f29b787317df7d35f26ae8e5c87a18576dd3fd72586b39cd64ed08c1a59c1de792d5a719ff03ab91d04957918a7f390ee3fa893bcceb8b6634fa5c25e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/343fa00612f2abd6d94599ce590d215fe8f295746f780b2262cad5adb9af97d9dd724aea9850a496007ef191dab8600456def342f35d1329966c8f0fea5853d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 15:42:37.174583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:42:37.174909) ========= 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=e10134013339c31d8d0c4708000001d6-1451339334.780404-1111997151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 15:42:37.256960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 15:42:37.257282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 15:42:37.257656) ========= ========= Total master_lag: 0.28 =========