builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1451544804.83 results: success (0) buildid: 20151230203035 builduid: 824d9eeeeb954d26a34d6f9890aa418a revision: a48a8eb8415f38e25c8672d0f5d58be865cca71f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.833347) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.833845) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.834225) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.896622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.897020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.987588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:24.987901) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.050558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.051089) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.051747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.052221) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 22:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-30 22:53:25 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161216 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.233108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.233460) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013987 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.286119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.286487) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a48a8eb8415f38e25c8672d0f5d58be865cca71f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a48a8eb8415f38e25c8672d0f5d58be865cca71f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 22:53:25,988 truncating revision to first 12 chars 2015-12-30 22:53:25,989 Setting DEBUG logging. 2015-12-30 22:53:25,989 attempt 1/10 2015-12-30 22:53:25,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a48a8eb8415f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 22:53:26,234 unpacking tar archive at: fx-team-a48a8eb8415f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.838353) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.838700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.848509) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.848831) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 22:53:25.849297) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 22:53:25.849613) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:26 INFO - MultiFileLogger online at 20151230 22:53:26 in /builds/slave/test-pgo 22:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:53:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:26 INFO - {'append_to_log': False, 22:53:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:26 INFO - 'branch': 'Fx-Team', 22:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:26 INFO - 'config_files': ('talos/linux_config.py',), 22:53:26 INFO - 'default_actions': ('clobber', 22:53:26 INFO - 'read-buildbot-config', 22:53:26 INFO - 'download-and-extract', 22:53:26 INFO - 'populate-webroot', 22:53:26 INFO - 'create-virtualenv', 22:53:26 INFO - 'install', 22:53:26 INFO - 'run-tests'), 22:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:26 INFO - 'download_minidump_stackwalk': True, 22:53:26 INFO - 'download_symbols': 'ondemand', 22:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:26 INFO - 'installer_path': 'installer.exe', 22:53:26 INFO - 'log_level': 'info', 22:53:26 INFO - 'log_name': 'talos', 22:53:26 INFO - 'log_to_console': True, 22:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:26 INFO - 'opt_config_files': (), 22:53:26 INFO - 'pip_index': False, 22:53:26 INFO - 'sps_profile': False, 22:53:26 INFO - 'sps_profile_interval': 0, 22:53:26 INFO - 'suite': 'dromaeojs-e10s', 22:53:26 INFO - 'system_bits': '32', 22:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:26 INFO - 'title': 'talos-linux64-ix-041', 22:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:26 INFO - 'use_talos_json': True, 22:53:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:26 INFO - 'work_dir': 'build'} 22:53:26 INFO - ##### 22:53:26 INFO - ##### Running clobber step. 22:53:26 INFO - ##### 22:53:26 INFO - Running pre-action listener: _resource_record_pre_action 22:53:26 INFO - Running main action method: clobber 22:53:26 INFO - rmtree: /builds/slave/test-pgo/build 22:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:27 INFO - Running post-action listener: _resource_record_post_action 22:53:27 INFO - ##### 22:53:27 INFO - ##### Running read-buildbot-config step. 22:53:27 INFO - ##### 22:53:27 INFO - Running pre-action listener: _resource_record_pre_action 22:53:27 INFO - Running main action method: read_buildbot_config 22:53:27 INFO - Using buildbot properties: 22:53:27 INFO - { 22:53:27 INFO - "project": "", 22:53:27 INFO - "product": "firefox", 22:53:27 INFO - "script_repo_revision": "production", 22:53:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:53:27 INFO - "repository": "", 22:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:53:27 INFO - "buildid": "20151230203035", 22:53:27 INFO - "pgo_build": "True", 22:53:27 INFO - "basedir": "/builds/slave/test-pgo", 22:53:27 INFO - "buildnumber": 417, 22:53:27 INFO - "slavename": "talos-linux64-ix-041", 22:53:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:27 INFO - "platform": "ubuntu64_hw", 22:53:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:53:27 INFO - "branch": "fx-team", 22:53:27 INFO - "repo_path": "integration/fx-team", 22:53:27 INFO - "revision": "a48a8eb8415f38e25c8672d0f5d58be865cca71f", 22:53:27 INFO - "stage_platform": "linux64-pgo", 22:53:27 INFO - "builduid": "824d9eeeeb954d26a34d6f9890aa418a", 22:53:27 INFO - "slavebuilddir": "test" 22:53:27 INFO - } 22:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:53:27 INFO - Running post-action listener: _resource_record_post_action 22:53:27 INFO - ##### 22:53:27 INFO - ##### Running download-and-extract step. 22:53:27 INFO - ##### 22:53:27 INFO - Running pre-action listener: _resource_record_pre_action 22:53:27 INFO - Running main action method: download_and_extract 22:53:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:27 INFO - https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/test_packages.json 22:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/test_packages.json 22:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:35 INFO - Downloaded 1302 bytes. 22:53:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:35 INFO - Using the following test package requirements: 22:53:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'jsshell-linux-x86_64.zip'], 22:53:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:35 INFO - https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:43 INFO - Downloaded 23195413 bytes. 22:53:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:53:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:53:44 INFO - Return code: 0 22:53:44 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 22:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:44 INFO - https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:47 INFO - Downloaded 23195413 bytes. 22:53:47 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 22:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:47 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 22:53:49 INFO - Return code: 0 22:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:49 INFO - https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:50 INFO - Downloaded 11132285 bytes. 22:53:50 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 22:53:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:50 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 22:53:50 INFO - Return code: 0 22:53:50 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')]} 22:53:50 INFO - https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H02boSwrTuGXXraBKgm7kw/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 22:53:51 INFO - Downloaded 54947100 bytes. 22:53:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:51 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:51 INFO - Contents: 22:53:51 INFO - build_url:https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:51 INFO - Running post-action listener: _resource_record_post_action 22:53:51 INFO - Running post-action listener: set_extra_try_arguments 22:53:51 INFO - ##### 22:53:51 INFO - ##### Running populate-webroot step. 22:53:51 INFO - ##### 22:53:51 INFO - Running pre-action listener: _resource_record_pre_action 22:53:51 INFO - Running main action method: populate_webroot 22:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:51 INFO - '--tppagecycles', 22:53:51 INFO - '7'], 22:53:51 INFO - 'tests': ['tsvgm']}}, 22:53:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'tests': ['damp', 'tps']}, 22:53:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['damp', 'tps']}, 22:53:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:51 INFO - 'other': {'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'other_l64': {'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:51 INFO - 'ts_paint', 22:53:51 INFO - 'tpaint', 22:53:51 INFO - 'sessionrestore', 22:53:51 INFO - 'sessionrestore_no_auto_restore']}, 22:53:51 INFO - 'svgr': {'tests': ['tsvgx', 22:53:51 INFO - 'tsvgr_opacity', 22:53:51 INFO - 'tart', 22:53:51 INFO - 'tscrollx', 22:53:51 INFO - 'cart']}, 22:53:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['tsvgx', 22:53:51 INFO - 'tsvgr_opacity', 22:53:51 INFO - 'tart', 22:53:51 INFO - 'tscrollx', 22:53:51 INFO - 'cart']}, 22:53:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'tests': ['tp5o']}, 22:53:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'talos_options': ['--e10s'], 22:53:51 INFO - 'tests': ['tp5o']}, 22:53:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'talos_options': ['--xperf_path', 22:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:51 INFO - 'tests': ['tp5n']}, 22:53:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:51 INFO - 'talos_options': ['--e10s', 22:53:51 INFO - '--xperf_path', 22:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:51 INFO - 'tests': ['tp5n']}}, 22:53:51 INFO - 'talos.zip': {'path': '', 22:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:51 INFO - Running post-action listener: _resource_record_post_action 22:53:51 INFO - ##### 22:53:51 INFO - ##### Running create-virtualenv step. 22:53:51 INFO - ##### 22:53:51 INFO - Running pre-action listener: _resource_record_pre_action 22:53:51 INFO - Running main action method: create_virtualenv 22:53:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:51 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 22:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:51 INFO - Using real prefix '/usr' 22:53:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:54 INFO - Installing pip.................done. 22:53:54 INFO - Return code: 0 22:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:53:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:53:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:53:54 INFO - Using env: {'DISPLAY': ':0', 22:53:54 INFO - 'HOME': '/home/cltbld', 22:53:54 INFO - 'LANG': 'en_US.UTF-8', 22:53:54 INFO - 'LANGUAGE': 'en_US:en', 22:53:54 INFO - 'LOGNAME': 'cltbld', 22:53:54 INFO - 'MAIL': '/var/mail/cltbld', 22:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:54 INFO - 'MOZ_NO_REMOTE': '1', 22:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:54 INFO - 'NO_EM_RESTART': '1', 22:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:54 INFO - 'SHELL': '/bin/bash', 22:53:54 INFO - 'SHLVL': '1', 22:53:54 INFO - 'TERM': 'linux', 22:53:54 INFO - 'TMOUT': '86400', 22:53:54 INFO - 'USER': 'cltbld', 22:53:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:54 INFO - '_': '/tools/buildbot/bin/python'} 22:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:53:54 INFO - Cleaning up... 22:53:54 INFO - Return code: 0 22:53:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:53:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:53:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:53:54 INFO - Using env: {'DISPLAY': ':0', 22:53:54 INFO - 'HOME': '/home/cltbld', 22:53:54 INFO - 'LANG': 'en_US.UTF-8', 22:53:54 INFO - 'LANGUAGE': 'en_US:en', 22:53:54 INFO - 'LOGNAME': 'cltbld', 22:53:54 INFO - 'MAIL': '/var/mail/cltbld', 22:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:54 INFO - 'MOZ_NO_REMOTE': '1', 22:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:54 INFO - 'NO_EM_RESTART': '1', 22:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:54 INFO - 'SHELL': '/bin/bash', 22:53:54 INFO - 'SHLVL': '1', 22:53:54 INFO - 'TERM': 'linux', 22:53:54 INFO - 'TMOUT': '86400', 22:53:54 INFO - 'USER': 'cltbld', 22:53:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:54 INFO - '_': '/tools/buildbot/bin/python'} 22:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:54 INFO - Downloading/unpacking psutil>=0.7.1 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:53:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:56 INFO - Installing collected packages: psutil 22:53:56 INFO - Running setup.py install for psutil 22:53:56 INFO - building 'psutil._psutil_linux' extension 22:53:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:53:56 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 22:53:56 INFO - building 'psutil._psutil_posix' extension 22:53:56 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 22:53:56 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 22:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:56 INFO - Successfully installed psutil 22:53:56 INFO - Cleaning up... 22:53:57 INFO - Return code: 0 22:53:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:53:57 INFO - Using env: {'DISPLAY': ':0', 22:53:57 INFO - 'HOME': '/home/cltbld', 22:53:57 INFO - 'LANG': 'en_US.UTF-8', 22:53:57 INFO - 'LANGUAGE': 'en_US:en', 22:53:57 INFO - 'LOGNAME': 'cltbld', 22:53:57 INFO - 'MAIL': '/var/mail/cltbld', 22:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:57 INFO - 'MOZ_NO_REMOTE': '1', 22:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:57 INFO - 'NO_EM_RESTART': '1', 22:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:57 INFO - 'SHELL': '/bin/bash', 22:53:57 INFO - 'SHLVL': '1', 22:53:57 INFO - 'TERM': 'linux', 22:53:57 INFO - 'TMOUT': '86400', 22:53:57 INFO - 'USER': 'cltbld', 22:53:57 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:57 INFO - '_': '/tools/buildbot/bin/python'} 22:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:58 INFO - Installing collected packages: mozsystemmonitor 22:53:58 INFO - Running setup.py install for mozsystemmonitor 22:53:59 INFO - Successfully installed mozsystemmonitor 22:53:59 INFO - Cleaning up... 22:53:59 INFO - Return code: 0 22:53:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53:59 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')]} 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 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')]} 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:59 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:53:59 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 22:53:59 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 22:53:59 INFO - Using env: {'DISPLAY': ':0', 22:53:59 INFO - 'HOME': '/home/cltbld', 22:53:59 INFO - 'LANG': 'en_US.UTF-8', 22:53:59 INFO - 'LANGUAGE': 'en_US:en', 22:53:59 INFO - 'LOGNAME': 'cltbld', 22:53:59 INFO - 'MAIL': '/var/mail/cltbld', 22:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:59 INFO - 'MOZ_NO_REMOTE': '1', 22:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:59 INFO - 'NO_EM_RESTART': '1', 22:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:59 INFO - 'SHELL': '/bin/bash', 22:53:59 INFO - 'SHLVL': '1', 22:53:59 INFO - 'TERM': 'linux', 22:53:59 INFO - 'TMOUT': '86400', 22:53:59 INFO - 'USER': 'cltbld', 22:53:59 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:59 INFO - '_': '/tools/buildbot/bin/python'} 22:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:59 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:54:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - Downloading docopt-0.6.1.tar.gz 22:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:01 INFO - Running setup.py install for blobuploader 22:54:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:54:01 INFO - Running setup.py install for requests 22:54:02 INFO - Running setup.py install for docopt 22:54:02 INFO - Successfully installed blobuploader requests docopt 22:54:02 INFO - Cleaning up... 22:54:02 INFO - Return code: 0 22:54:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:02 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')]} 22:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:02 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')]} 22:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:02 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:54:02 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 22:54:02 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 22:54:02 INFO - Using env: {'DISPLAY': ':0', 22:54:02 INFO - 'HOME': '/home/cltbld', 22:54:02 INFO - 'LANG': 'en_US.UTF-8', 22:54:02 INFO - 'LANGUAGE': 'en_US:en', 22:54:02 INFO - 'LOGNAME': 'cltbld', 22:54:02 INFO - 'MAIL': '/var/mail/cltbld', 22:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:02 INFO - 'MOZ_NO_REMOTE': '1', 22:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:02 INFO - 'NO_EM_RESTART': '1', 22:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:02 INFO - 'SHELL': '/bin/bash', 22:54:02 INFO - 'SHLVL': '1', 22:54:02 INFO - 'TERM': 'linux', 22:54:02 INFO - 'TMOUT': '86400', 22:54:02 INFO - 'USER': 'cltbld', 22:54:02 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:02 INFO - '_': '/tools/buildbot/bin/python'} 22:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:02 INFO - Running setup.py (path:/tmp/pip-BTlWTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:02 INFO - Running setup.py (path:/tmp/pip-sMa2ha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:02 INFO - Running setup.py (path:/tmp/pip-1mB0kM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:02 INFO - Running setup.py (path:/tmp/pip-AcOt5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:02 INFO - Running setup.py (path:/tmp/pip-eIBsDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:02 INFO - Running setup.py (path:/tmp/pip-dAfvZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:02 INFO - Running setup.py (path:/tmp/pip-2x2YAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:03 INFO - Running setup.py (path:/tmp/pip-3y_oGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:03 INFO - Running setup.py (path:/tmp/pip-92sCBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:03 INFO - Running setup.py (path:/tmp/pip-AEajDS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:03 INFO - Running setup.py (path:/tmp/pip-NjwoMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:03 INFO - Running setup.py (path:/tmp/pip-ikuusn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:03 INFO - Running setup.py (path:/tmp/pip-eeZ2kB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:03 INFO - Running setup.py (path:/tmp/pip-_kN6M9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:03 INFO - Running setup.py (path:/tmp/pip-YUmO5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:03 INFO - Running setup.py (path:/tmp/pip-xxgMFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:03 INFO - Running setup.py (path:/tmp/pip-E6jVNL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:03 INFO - Running setup.py install for manifestparser 22:54:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:54:03 INFO - Running setup.py install for mozcrash 22:54:03 INFO - Running setup.py install for mozdebug 22:54:04 INFO - Running setup.py install for mozdevice 22:54:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for mozfile 22:54:04 INFO - Running setup.py install for mozhttpd 22:54:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for mozinfo 22:54:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for mozInstall 22:54:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for mozleak 22:54:04 INFO - Running setup.py install for mozlog 22:54:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for moznetwork 22:54:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:54:04 INFO - Running setup.py install for mozprocess 22:54:04 INFO - Running setup.py install for mozprofile 22:54:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:54:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:54:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:54:05 INFO - Running setup.py install for mozrunner 22:54:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:54:05 INFO - Running setup.py install for mozscreenshot 22:54:05 INFO - Running setup.py install for moztest 22:54:05 INFO - Running setup.py install for mozversion 22:54:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:54:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:05 INFO - Cleaning up... 22:54:05 INFO - Return code: 0 22:54:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:05 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')]} 22:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 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')]} 22:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:05 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:54:05 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 22:54:05 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 22:54:05 INFO - Using env: {'DISPLAY': ':0', 22:54:05 INFO - 'HOME': '/home/cltbld', 22:54:05 INFO - 'LANG': 'en_US.UTF-8', 22:54:05 INFO - 'LANGUAGE': 'en_US:en', 22:54:05 INFO - 'LOGNAME': 'cltbld', 22:54:05 INFO - 'MAIL': '/var/mail/cltbld', 22:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:05 INFO - 'MOZ_NO_REMOTE': '1', 22:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:05 INFO - 'NO_EM_RESTART': '1', 22:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:05 INFO - 'SHELL': '/bin/bash', 22:54:05 INFO - 'SHLVL': '1', 22:54:05 INFO - 'TERM': 'linux', 22:54:05 INFO - 'TMOUT': '86400', 22:54:05 INFO - 'USER': 'cltbld', 22:54:05 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:05 INFO - '_': '/tools/buildbot/bin/python'} 22:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:05 INFO - Running setup.py (path:/tmp/pip-LQhdJ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:05 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)) 22:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:05 INFO - Running setup.py (path:/tmp/pip-Lyl5mL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:05 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)) 22:54:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:05 INFO - Running setup.py (path:/tmp/pip-4MLckk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:06 INFO - Running setup.py (path:/tmp/pip-WG4fkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:06 INFO - Running setup.py (path:/tmp/pip-3D_k1v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:06 INFO - Running setup.py (path:/tmp/pip-s17SmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:06 INFO - Running setup.py (path:/tmp/pip-DJsa26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:06 INFO - Running setup.py (path:/tmp/pip-yW2HYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:06 INFO - Running setup.py (path:/tmp/pip-tjwMpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:06 INFO - Running setup.py (path:/tmp/pip-hkyoBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:06 INFO - Running setup.py (path:/tmp/pip-dnPDoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:06 INFO - Running setup.py (path:/tmp/pip-DsrKXS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:06 INFO - Running setup.py (path:/tmp/pip-OZNw5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:06 INFO - Running setup.py (path:/tmp/pip-8ITpok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:06 INFO - Running setup.py (path:/tmp/pip-fqmjJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:06 INFO - Running setup.py (path:/tmp/pip-JLw7B4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:06 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)) 22:54:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:06 INFO - Running setup.py (path:/tmp/pip-gX71ac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:07 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)) 22:54:07 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)) 22:54:07 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)) 22:54:07 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)) 22:54:07 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)) 22:54:07 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)) 22:54:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:07 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 22:54:07 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 22:54:07 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 22:54:07 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 22:54:07 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 22:54:07 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 22:54:08 INFO - Downloading blessings-1.5.1.tar.gz 22:54:08 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 22:54:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:08 INFO - Installing collected packages: blessings 22:54:08 INFO - Running setup.py install for blessings 22:54:08 INFO - Successfully installed blessings 22:54:08 INFO - Cleaning up... 22:54:08 INFO - Return code: 0 22:54:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:09 INFO - Reading from file tmpfile_stdout 22:54:09 INFO - Current package versions: 22:54:09 INFO - argparse == 1.2.1 22:54:09 INFO - blessings == 1.5.1 22:54:09 INFO - blobuploader == 1.2.4 22:54:09 INFO - docopt == 0.6.1 22:54:09 INFO - manifestparser == 1.1 22:54:09 INFO - mozInstall == 1.12 22:54:09 INFO - mozcrash == 0.16 22:54:09 INFO - mozdebug == 0.1 22:54:09 INFO - mozdevice == 0.47 22:54:09 INFO - mozfile == 1.2 22:54:09 INFO - mozhttpd == 0.7 22:54:09 INFO - mozinfo == 0.9 22:54:09 INFO - mozleak == 0.1 22:54:09 INFO - mozlog == 3.1 22:54:09 INFO - moznetwork == 0.27 22:54:09 INFO - mozprocess == 0.22 22:54:09 INFO - mozprofile == 0.28 22:54:09 INFO - mozrunner == 6.11 22:54:09 INFO - mozscreenshot == 0.1 22:54:09 INFO - mozsystemmonitor == 0.0 22:54:09 INFO - moztest == 0.7 22:54:09 INFO - mozversion == 1.4 22:54:09 INFO - psutil == 3.1.1 22:54:09 INFO - requests == 1.2.3 22:54:09 INFO - wsgiref == 0.1.2 22:54:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:09 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')]} 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 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')]} 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:54:09 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 22:54:09 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 22:54:09 INFO - Using env: {'DISPLAY': ':0', 22:54:09 INFO - 'HOME': '/home/cltbld', 22:54:09 INFO - 'LANG': 'en_US.UTF-8', 22:54:09 INFO - 'LANGUAGE': 'en_US:en', 22:54:09 INFO - 'LOGNAME': 'cltbld', 22:54:09 INFO - 'MAIL': '/var/mail/cltbld', 22:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:09 INFO - 'MOZ_NO_REMOTE': '1', 22:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:09 INFO - 'NO_EM_RESTART': '1', 22:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:09 INFO - 'SHELL': '/bin/bash', 22:54:09 INFO - 'SHLVL': '1', 22:54:09 INFO - 'TERM': 'linux', 22:54:09 INFO - 'TMOUT': '86400', 22:54:09 INFO - 'USER': 'cltbld', 22:54:09 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:09 INFO - '_': '/tools/buildbot/bin/python'} 22:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 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)) 22:54:09 INFO - Cleaning up... 22:54:09 INFO - Return code: 0 22:54:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:54:09 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')]} 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 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')]} 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:54:09 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 22:54:09 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 22:54:09 INFO - Using env: {'DISPLAY': ':0', 22:54:09 INFO - 'HOME': '/home/cltbld', 22:54:09 INFO - 'LANG': 'en_US.UTF-8', 22:54:09 INFO - 'LANGUAGE': 'en_US:en', 22:54:09 INFO - 'LOGNAME': 'cltbld', 22:54:09 INFO - 'MAIL': '/var/mail/cltbld', 22:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:09 INFO - 'MOZ_NO_REMOTE': '1', 22:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:09 INFO - 'NO_EM_RESTART': '1', 22:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:09 INFO - 'SHELL': '/bin/bash', 22:54:09 INFO - 'SHLVL': '1', 22:54:09 INFO - 'TERM': 'linux', 22:54:09 INFO - 'TMOUT': '86400', 22:54:09 INFO - 'USER': 'cltbld', 22:54:09 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:09 INFO - '_': '/tools/buildbot/bin/python'} 22:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:09 INFO - Downloading/unpacking jsonschema 22:54:09 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 22:54:09 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 22:54:09 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 22:54:09 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 22:54:09 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 22:54:09 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 22:54:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:11 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 22:54:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:54:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:11 INFO - warning: no files found matching '*.txt' 22:54:11 INFO - no previously-included directories found matching 'build' 22:54:11 INFO - no previously-included directories found matching 'dist' 22:54:11 INFO - no previously-included directories found matching '.git*' 22:54:11 INFO - Installing collected packages: jsonschema, functools32 22:54:11 INFO - Running setup.py install for functools32 22:54:11 INFO - warning: no files found matching '*.txt' 22:54:11 INFO - no previously-included directories found matching 'build' 22:54:11 INFO - no previously-included directories found matching 'dist' 22:54:11 INFO - no previously-included directories found matching '.git*' 22:54:11 INFO - Successfully installed jsonschema functools32 22:54:11 INFO - Cleaning up... 22:54:11 INFO - Return code: 0 22:54:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:11 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')]} 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 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')]} 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:11 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 0x7f8bf284df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a21630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', '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 22:54:11 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 22:54:11 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 22:54:11 INFO - Using env: {'DISPLAY': ':0', 22:54:11 INFO - 'HOME': '/home/cltbld', 22:54:11 INFO - 'LANG': 'en_US.UTF-8', 22:54:11 INFO - 'LANGUAGE': 'en_US:en', 22:54:11 INFO - 'LOGNAME': 'cltbld', 22:54:11 INFO - 'MAIL': '/var/mail/cltbld', 22:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:11 INFO - 'MOZ_NO_REMOTE': '1', 22:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:11 INFO - 'NO_EM_RESTART': '1', 22:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:11 INFO - 'SHELL': '/bin/bash', 22:54:11 INFO - 'SHLVL': '1', 22:54:11 INFO - 'TERM': 'linux', 22:54:11 INFO - 'TMOUT': '86400', 22:54:11 INFO - 'USER': 'cltbld', 22:54:11 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:11 INFO - '_': '/tools/buildbot/bin/python'} 22:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:11 INFO - Downloading/unpacking flake8 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:11 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 22:54:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:13 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 22:54:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:13 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 22:54:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:14 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 22:54:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 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 22:54:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:54:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:14 INFO - no previously-included directories found matching 'docs/_build' 22:54:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:14 INFO - Running setup.py install for pep8 22:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:14 INFO - no previously-included directories found matching 'docs/_build' 22:54:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:14 INFO - Cleaning up... 22:54:14 INFO - Return code: 0 22:54:14 INFO - Running post-action listener: _resource_record_post_action 22:54:14 INFO - Running post-action listener: _start_resource_monitoring 22:54:14 INFO - Starting resource monitoring. 22:54:14 INFO - ##### 22:54:14 INFO - ##### Running install step. 22:54:14 INFO - ##### 22:54:14 INFO - Running pre-action listener: _resource_record_pre_action 22:54:14 INFO - Running main action method: install 22:54:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:14 INFO - Reading from file tmpfile_stdout 22:54:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:14 INFO - Reading from file tmpfile_stdout 22:54:14 INFO - Output received: 22:54:14 INFO - Usage: mozinstall [options] installer 22:54:14 INFO - Options: 22:54:14 INFO - -h, --help show this help message and exit 22:54:14 INFO - -d DEST, --destination=DEST 22:54:14 INFO - Directory to install application into. [default: 22:54:14 INFO - "/builds/slave/test-pgo"] 22:54:14 INFO - --app=APP Application being installed. [default: firefox] 22:54:14 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:14 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'] 22:54:14 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 22:54:30 INFO - Reading from file tmpfile_stdout 22:54:30 INFO - Output received: 22:54:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:30 INFO - Running post-action listener: _resource_record_post_action 22:54:30 INFO - ##### 22:54:30 INFO - ##### Running run-tests step. 22:54:30 INFO - ##### 22:54:30 INFO - Running pre-action listener: _resource_record_pre_action 22:54:30 INFO - Running main action method: run_tests 22:54:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:30 INFO - Python 2.7.3 22:54:30 INFO - Return code: 0 22:54:30 INFO - grabbing minidump binary from tooltool 22:54: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')]} 22:54:30 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 0x1ab2840>, '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 0x1a1f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:30 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 22:54:30 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 22:54:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:30 INFO - Return code: 0 22:54:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:31 INFO - Return code: 0 22:54:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:54:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:54:31 INFO - Using env: {'DISPLAY': ':0', 22:54:31 INFO - 'HOME': '/home/cltbld', 22:54:31 INFO - 'LANG': 'en_US.UTF-8', 22:54:31 INFO - 'LANGUAGE': 'en_US:en', 22:54:31 INFO - 'LOGNAME': 'cltbld', 22:54:31 INFO - 'MAIL': '/var/mail/cltbld', 22:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:31 INFO - 'MOZ_NO_REMOTE': '1', 22:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:31 INFO - 'NO_EM_RESTART': '1', 22:54:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:31 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:31 INFO - 'SHELL': '/bin/bash', 22:54:31 INFO - 'SHLVL': '1', 22:54:31 INFO - 'TERM': 'linux', 22:54:31 INFO - 'TMOUT': '86400', 22:54:31 INFO - 'USER': 'cltbld', 22:54:31 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317', 22:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:31 INFO - '_': '/tools/buildbot/bin/python'} 22:54:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:54:31 INFO - mozversion application_buildid: 20151230203035 22:54:31 INFO - mozversion application_changeset: a48a8eb8415f38e25c8672d0f5d58be865cca71f 22:54:31 INFO - mozversion application_display_name: Nightly 22:54:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:31 INFO - mozversion application_name: Firefox 22:54:31 INFO - mozversion application_remotingname: firefox 22:54:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:54:31 INFO - mozversion application_vendor: Mozilla 22:54:31 INFO - mozversion application_version: 46.0a1 22:54:31 INFO - mozversion platform_buildid: 20151230203035 22:54:31 INFO - mozversion platform_changeset: a48a8eb8415f38e25c8672d0f5d58be865cca71f 22:54:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:54:31 INFO - mozversion platform_version: 46.0a1 22:54:31 INFO - using testdate: 1451544871 22:54:31 INFO - actual date: 1451544871 22:54:31 INFO - starting webserver on 'localhost:59165' 22:54:31 INFO - SUITE-START | Running 3 tests 22:54:31 INFO - TEST-START | dromaeo_css 22:54:31 INFO - operating with platform_type : linux_ 22:54:31 INFO - Initialising browser for dromaeo_css test... 22:54:31 INFO - TEST-INFO | started process 30224 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCPJ9Qe/profile http://localhost:59165/getInfo.html) 22:54:36 INFO - PROCESS | 30224 | __metrics Screen width/height:1600/1200 22:54:36 INFO - PROCESS | 30224 | colorDepth:24 22:54:36 INFO - PROCESS | 30224 | Browser inner width/height: 1024/697 22:54:36 INFO - PROCESS | 30224 | __metrics 22:54:36 INFO - PROCESS | 30224 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:54:37 INFO - TEST-INFO | 30224: exit 0 22:54:37 INFO - Browser initialized. 22:54:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:37 INFO - TEST-INFO | started process 30358 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCPJ9Qe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:49 INFO - PROCESS | 30358 | RSS: Main: 149917696 22:54:49 INFO - PROCESS | 30358 | 22:55:39 INFO - PROCESS | 30358 | 1451544939173 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] 22:57:47 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59165/tests/dromaeo/cssquery-ext.html) 22:57:48 INFO - PROCESS | 30358 | RSS: Main: 157519872 22:57:48 INFO - PROCESS | 30358 | 23:00:51 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-ext.html (next: http://localhost:59165/tests/dromaeo/cssquery-jquery.html) 23:00:51 INFO - PROCESS | 30358 | RSS: Main: 153452544 23:00:51 INFO - PROCESS | 30358 | 23:03:53 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59165/tests/dromaeo/cssquery-mootools.html) 23:03:53 INFO - PROCESS | 30358 | RSS: Main: 154882048 23:03:53 INFO - PROCESS | 30358 | 23:06:55 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59165/tests/dromaeo/cssquery-prototype.html) 23:06:56 INFO - PROCESS | 30358 | RSS: Main: 152129536 23:06:56 INFO - PROCESS | 30358 | 23:09:58 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59165/tests/dromaeo/cssquery-yui.html) 23:09:59 INFO - PROCESS | 30358 | RSS: Main: 152121344 23:09:59 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | Cycle 1(1): loaded http://localhost:59165/tests/dromaeo/cssquery-yui.html (next: http://localhost:59165/tests/dromaeo/cssquery-dojo.html) 23:13:01 INFO - PROCESS | 30358 | RSS: Main: 155746304 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | __start_tp_report 23:13:01 INFO - PROCESS | 30358 | _x_x_mozilla_page_load 23:13:01 INFO - PROCESS | 30358 | _x_x_mozilla_page_load_details 23:13:01 INFO - PROCESS | 30358 | |i|pagename|runs| 23:13:01 INFO - PROCESS | 30358 | |0;dojo.html;3070.9385812283754;3097.495259954095;3119.3449375631117;3120.6411262704796;3145.9461080538013;5234.319538459995;5296.496832800887;5296.89406211876;5340.973295133528;5348.759305831237;5286.920696189561;5303.549198318147;5332.866678333044;5386.111291636885;5480.91778623321;4896.853094407174;4933.136701077315;4935.851924442254;4997.50024997501;5045.772940217681;4955.801767929279;4965.280034395028;4995.100881841267;5025.773840177182;5030.2957585938;4802.111609352263;4831.710097394168;4890.315355850184;4914.0908931847725;4938.358013458227;4844.539768721966;4849.199882019462;4873.731944743037;4877.780499877514;4910;4829.541193586604;4850.902981940341;4855.126077306083;4857.8299759508245;4866.294387313855;5075.543201111881;5161.096808058574;5168.767405466763;5219.686818790885;5243.449437809051;5720.141978703186;5722.914156287659;5726.427357264281;5744.396838331999;5747.655140691572;5711.428857114297;5779.739911703983;5780.450857168562;5783.21926539916;5800.274965629296;5415.377231618375;5430.212619170198;5505.3393592768725;5511.3937466878615;5553.278073850414;5963;5965.105234214902;5967.343592204854;5983.222181116427;5993.850153746104;5482.5613950883835;5597.720113994284;5684.54523638108;5688.687122208318;5704.1443783432815;5650.830475085754;5730.255066841284;5740.6268592541355;5759.1649210865025;5797.275340582427;5757.8560535986935;5766.596338256366;5779.335376431764;5803.738831752581;5809.50619197373;5679.659220446786;5682.460166284196;5753.424657534213;5807.390224026501;5840.795572154954;4519.344695019204;4519.7740112994215;4526.660500462479;4548.499665036843;4562.315652652129;3989.2819292527042;4002.2595819772855;4005.679545636342;4030.2946984277633;4037.6971727120585;5320.281761962163;5362.758675859595;5403.13549832025;5461.918071228855;5510.393856675762;5870.383609720918;5903.35063143054;5916.970415147896;5919;5932.614380065282;5445.809396671098;5464.9453505464435;5469.042917489423;5477.890442191134;5483.040467918098;4930.482299358588;5021.6735912165595;5029.899402011939;5094.286799848024;5136.845894623168;6037.879242415215;6042.848928776728;6046.27444706638;6055.243094613262;6062.484688801501;5622.7750889963945;5846.532277417881;5847.649141051551;5869.266341707286;5869.325027621708;5866.413358664099;5875.794347197828;5987.520998320211;5998.040313549811;6042.244719410074;5767;5786;5787.710614469175;5792.362840087671;5799.884002320015;5608.915866262091;5723.513501352431;5808.593398462067;5867.149263356875;5876.941230587639;5556.749946252347;5571.331440227036;5623.746931388016;5632.521235694848;5665.5750818689585;5643.576731745054;5693.686847223276;5702.45826646468;5705.515031222392;5720.685362305113;5509.256250406304;5513.3108361454815;5603.663780173202;5616.803411880564;5624.29696287964;5747.281589801275;5806.187133801187;5809.448102430262;5812.21535092757;5838.912416313674;5635.211070450222;5637.689927054052;5668;5685.943140568541;5707.571932105026 23:13:01 INFO - PROCESS | 30358 | |1;ext.html;522.8353068783331;524.879277766114;579.4726798613261;580.834462178279;582.2169182449605;27427.725722742765;27994;36080.639193608054;36645;36747.26505469889;39467;40146.59853401465;40187;40282.59717402825;40353.59646403542;8536.74389768308;8680.175383338572;8720.258778003878;8721.12788721129;8750.3874728769;8430.5363205024;8492.235698787108;8578.914210857905;8586.184312490303;8614.784630384227;8744.213020828125;8792.47245165289;8826.205641492264;8863.556822158898;8921.59852806622;8696.521691307007;8724.825503489927;8800.73597792064;8802.779930501725;8804.031556528776;8545.316374690072;8644.005939316996;8712.825743485095;8717.259032982203;8758.343124265642;39812.402813957815;40022.799886000386;40407.7979610103;40504.59495405038;40643.59356406428;3285.8685652573868;3409.1817963688786;3457.844397002141;3848.268828922524;3963.1677347757004;29412.70587294121;29430.70569294301;29641;29876.253093672614;30825;3623.565172179329;3634.4730014148063;3648.5074514940407;3744.8689295874515;3756.8309426075893;258769;260186;260190;260330;260372;55746.72126639341;55836;55993;56212;56339.71830140823;60769;66983.33016669868;68014.65992670105;68351;68428.31571684219;15632.92183539075;15734.449294274646;15850.44523441674;15880.761788573182;15978.280977356048;11711.355875426932;11749.530018799323;11764;11774;11826;20078.69881951772;20388;20398.490037749176;20453.2841350552;20534;8152;8417.494950303002;8428.536430496259;8432.030316513557;8486.787830304169;941.9105185007413;979.1139019187647;1005.6228914157191;1030.5723124903232;1122.646366394583;27698.446031079264;29038.564421533694;29234.707652923626;32664.510032349535;33652;1066.4987455895716;1083.815751322277;1160.6344001639457;1163.6974386659529;1166.521726092315;15099.169545674873;15338.846611533965;15420;15569.221538923008;15600.29798659063;707979;721080;727452;728649;729309;54059.72970135203;54235.72882135564;54637;54780.17829732557;54787.72606136944;1361.2309045389322;1389.3747813483972;1394.268009295108;1399.846016938136;1409.3587417724912;29357.26606834846;30152.24619384445;30651.693483064882;31562.210944726565;31920.52119218167;49098.26352604642;50039.749801250764;50091.24863126983;50112.74943625258;50184;302408;302458;303634;304612;305388;42298.36552451777;42895.7855210722;43173.78413107914;43555.12889742251;43558.78220608877;45629.77185114053;45645.54354456413;46037;46678;46842.53157468382;37718.2456350877;38653.226935460574;38740.61259387483;39122.217555649295;40269.79865100656;33764.987050388525;38808.80595597004;41697.58302416937;43053;44482.55517444784;38755;41436.378454323814;41551.79224103981;41760;42341.78829105958;28935;29430.26424339323;30827.691723082484;31911.68088319087;31940.5208921871;23772.167974120825;24369;24457;27034.594481083193;27101.322466938484 23:13:01 INFO - PROCESS | 30358 | |2;jquery.html;357.4495277273;359.78592737321287;367.6305313160274;367.6709345136103;369.0588998054959;16657.25042373093;16981;17053.232604532794;17409.564760880985;17459.563510912234;10926.071283940875;11495.367754773504;16230.675386492263;16239.594010149753;16256.593585160377;4788.138135135683;5378.596605254602;5392.622516423852;5398.271233383502;5402;5353.892922141555;5426.728663566825;5430.3755068167075;5438.293021907147;5438.3473983121885;4989.625778066641;5077.466865979056;5146.305248791403;5220.29526013987;5266.4733526647415;5184.937087896972;5219.347581552287;5223.895522089556;5283.101872681634;5898;5279.947200527984;5290.973545132289;5291.86770330741;5298.682079075268;5305.283786688786;12445.502179912794;13495.527656532073;17862.55343616407;20012.299569515144;20023.599528009505;2103.3689893032183;2116.6719158530454;2212.513247085639;2238.0488292475634;2254.211026140854;9637.132658060807;9638.710838674851;9787;12013.699657508545;12602.495900163982;1815.1831675745834;1818.0546116019727;1822.7903791064066;1846.8245516675895;1873.4754268804757;53022;55512.722436387965;58128.418715812724;61806;62130;9910.950445247872;10211.489425528694;10324.328918620266;10367;10388.584456621651;13309.467621295233;13401;13412.262325571992;13472.326383680776;13498.595042148554;7756.6509507072315;7784.2215778421705;7793.844123117619;7807.570583617956;7912.971313729178;7582.54504729707;7633.503822251536;7669.654865531064;7677.731279405194;7695.461317707706;4410.051838854662;4447.955520444754;4480.059187570581;4483.394741709827;4494.213512635276;1834.7981722010568;1858.6840237159715;1860.6557786809483;1877.2866310801808;1881.0688709089088;851.4720873058743;924.8658944453017;942.2838642631513;958.4009993753904;1022.7340891368298;15719.292631831595;15744.291506882219;15819.446319378767;16286.755698664529;16365.099919504304;945.9148676619;959.6785076999143;968.3608818179968;987.1206159791943;1037.5382954585136;9253.583588738524;9409.388389754644;9563.952180239054;9677.22582193437;9881.25890558211;498921;501129;507759;524126;526700;78083.8287425689;78158;78530.1102417321;79452.20547794564;81039.59480202562;1152.7002979225463;1154.786364522566;1209.4920133543933;1220.2922305063041;1241.2986662535639;15726.606834829221;16009.439669611507;16017.199140042718;16052.598685032968;16412.343506259615;34843.30313393768;34919.65080349164;35085.649143508235;35830.20848957489;36104.45843312405;44909;46273.537264626924;46587.53412465832;46618.76690616525;46890.296645551025;9330.533473326443;9632.662856799978;9854.507274636097;9868.210543156674;9925.503724813587;11433.256838305484;11463.541458341573;11715.707107322045;11730.589429369931;13633.590992270249;13457.865421345661;13516.6620834476;14053.45412004699;14060.859391405955;14539.854601454274;13672.453101875813;13905.443782249002;14019.789703154256;14095.718085638026;14155.150690958164;14282.2144782038;14504;14537.491187808377;14706.41174353014;15055.171965541562;9189.77025574366;9722.222222222346;9856;9920.652777153055;9936.503174841084;10147.188224942134;10608.628697995533;14790.926045369704;14833.110013399231;14967.176805275814 23:13:01 INFO - PROCESS | 30358 | |3;mootools.html;1480.4004378226819;1491.8284397294315;1518.5292559306615;1572.787673664055;1615.450746746106;7565.167831538526;7695.5382677039415;7848.764537063883;7966.283034526891;7993.999999999993;7653.502522336044;7660.119086305062;7731.7680469586;7742.458027938046;7748.845023099549;2267.875266860322;2276.7837055479786;2282.5206706591634;2314.109068008812;2317.536492701458;2322.8954697038675;2347.5539647467012;2373.098222675381;2379.4765151666606;2380.2502211803226;2285.5771682238756;2316.4324740438615;2348.9530209395803;2350.8707021113833;2359.8938047787806;2287.874166920819;2301.470661747799;2326.2904814031713;2328.7787660172257;2348.6477028445697;2323.6979192705007;2363.196513185508;2364.5270945810908;2365.491419344849;2365.562370961378;7620.237976202336;7747.147813740484;7755.612219389008;7757.301842834116;7807.765767026942;4773.546513081252;4803.423589169287;4812.374391329105;4830.85507434774;4876.195427754452;3157.8263195524237;3182.427163110639;3214.9357012859614;3217.3565286942703;3225.4194245035883;1004.5529739266029;1007.89417111203;1025.5538840604286;1041.666666666667;1071.0788721699332;10863.67408977724;10897.400642964712;10914.126869850394;10943.124550036058;10961.84900585443;4216.746995180299;4333.804978775963;4340.305551111807;4386.934195987063;4427.645788336989;8623.223909848019;8689.739307820775;8690.304775617935;8691.261242794308;8701.390902636755;4688.8124475021295;4689.531046895283;4699.671023028355;4718.339432479455;4720.929186062212;4248.468941382327;4269.847141271839;4274.487061552633;4287.614114729689;4297.484301883794;3510.648935106469;3534.8511733686655;3546.858125674996;3578.4274516077303;3591.2996965591983;1137.181229514748;1146.4726225936163;1161.506359797083;1169.316184694038;1178.9233699809486;1031.1080915008613;1036.8133735927454;1069.4599227390117;1158.1256151605485;1290.9548165814151;6851.760188393382;6980.336867997532;7023.89464158038;7035.050268213828;7068.0811494506415;1037.113268155731;1048.5386429970788;1050.6060227414719;1113.33200079953;1139.6239241050434;5231.372235331784;5294.523492885659;5314.362276526842;5331.840044798662;5333.839984800462;9327.300452465957;9366.672166474276;9547.809043819085;9571.61713531451;9619.374740641835;9386.155246027754;9420.152186303128;9423.528823558794;9478.099580539838;9570.234381249484;7356.595387253646;7377.5204611700065;7551.320381165721;7554.848903022019;7581;6707.631080290631;6732.831679208059;6750.898736518858;6752.3922846944015;6758.898616520854;8279.172082791672;8510.234078932926;8555.35834812404;8608.48349099056;8633.179847914438;8591.355648326275;8754.69358572447;8832.5583720815;8844.248238899509;8865.822683546421;6592.736290548324;6608.801735947929;6773.525853190229;6787.62668053242;6788.7284508619105;7571.053618297713;7609.048868891388;7666.310032097138;7669.233076692286;7680.3471704905705;6853.280405557344;7110.822229444305;7185.604791736296;7336.449766267658;7343.3390994810725;6840.213375461686;6912.343327383891;6951.8609627806145;7044.542104763174;7123.931410288498;7104.467164962545;7134.571925684476;7136.500444968802;7157.355837974607;7195.784126476214;6267.122602835698;6308.27454842699;6336.017917222838;6339.619622822645;6350.333215012542;6205.441510264098;6308.684565771785;6337.7148028337915;6339.5562310637815;6368.140301059298 23:13:01 INFO - PROCESS | 30358 | |4;prototype.html;339.8844392906412;340.4008944258105;341.4400383371273;350.19105865450797;351.0836716170794;6191.442770150686;6200.441960223579;6244.500439964803;6260.436560709535;6354.396332348431;6062.060380640996;6187.381261873822;6188.5358598105095;6199.907001394983;6241.3134555199;4769.499202583731;4818.494058123882;4818.494058123882;4824.831130910419;4826.372571565709;4796.688215266014;4803.207470767319;4823.686460380081;4831;4845.273209018657;4705.670603057787;4784.641151913603;4798.592119669832;4811.639127065467;4813.278008298766;4784.473707892146;4785.042991401716;4794.664373493857;4802.399700037496;4804.20730579454;4209.200251952119;4218.2196293685765;4230.090530535918;4232.132412855357;4242.045539753562;5970.910436343458;5971.134185543072;5983.401659834025;5985.880282394328;5994.7901823436405;5444.428335024805;5563.721813909288;5566.693831839248;5598.356189038232;5604.3835178130375;6605.966970165118;6614.140161778938;6614.669266536702;6619.271880093186;6630.569013014187;4648.581627653527;4659.4175728034;4660.836870709542;4664.580187783115;4673.929891051637;6701.966490167518;6927.653617319113;6932.064171336855;6947.861042779166;6957.5129740918155;4608.3778689876435;4672.275797251432;4682.993156471375;4684.81260749573;4689.742064186503;4732.38478997735;4738.857834264978;4745.691530050535;4748.216544270157;4764.761761911891;5490.56075513958;5505;5511.614187006871;5524.729312258203;5525.475079867487;6509.1863517060365;6676.332366763285;6701.530892837454;6708.42978346846;6714.832129196711;1628.51958672192;1662.2686018151974;1664.4257731082757;1665.350513299814;1671.2061770659084;1099.6371197504964;1101.3281898042187;1105.3147048829776;1110.777844431117;1111.8109921313396;6159.384061593805;6194.915889719371;6196.349383314687;6201.658908760061;6213.627182369072;6752.527323087336;6767.627780472023;6768.492363072789;6772.119624448888;6777.830554236085;6074.787382441594;6166.784162554289;6182.938170618326;6187.226596675416;6203.6587987660205;3673.8897833065053;3682.8710995115043;3690.944635830465;3692.7230457715777;3706.129059670975;7046.224915259318;7047.92952070483;7055.188653304833;7059.435245180373;7060.470464715167;6806.8298292542095;6956.8956465653055;6961.82595435108;6975.8604827903155;6988.37104660583;6969.54697944632;7044.964775176091;7047.788566343121;7053.753118640823;7064.43484521237;6755.121834161724;6756.155480564929;6766.5263431559315;6766.93233067663;6775.559588626724;6586.2755096940255;6671.232808226922;6695.196576410862;6707;6707.195136583641;6979.127609048869;7017.350922533303;7018.5788852669;7019.6490175492045;7023.543469674455;4645.814167433265;4667.953320466888;4668.2297420926525;4672.883177920579;4683.4614019386845;6728.158980127484;6732.461403087644;6787.796366109024;6802.82992925161;6870.690818913061;6618.536702430783;6656.068150459037;6670.066190733398;6680.198376194888;6684.966575167093;6691.498137639794;6695.4978376620975;6699.9665001674675;6702.932970670231;6704.229013663296;6431.646259455775;6566.179227596551;6594.307597702172;6601.801945941629;6619.569727967667;6685.130932978682;6725.159355080615;6760.898586521108;6762.830929226612;6775.288594697486;6563.638999855054;6567.835804104936;6602.10871532337;6603.108580341593;6603.306652801387 23:13:01 INFO - PROCESS | 30358 | |5;yui.html;720;726.8909663550467;738.6491416577123;773.760134358349;843.2621456225802;12832.48670053198;12845.807312890314;12995.090343675947;12995.480180792756;13066.738665226701;11376.772464550704;11387.032102271316;11406.087512998962;11437.42812859358;11451.141164412682;667.5961043568644;677.0926957876444;804.6338915793315;810.2019510781876;814.071957967917;817.1134319263606;824.8061705499202;831.6964308027586;833.3458235285302;833.9708110216113;846.9915300846974;860.1785295043219;860.6299291304767;862.4006315610653;864.4899509289518;852.799592095857;864.6195673903494;868.192580899763;869.5652173913044;869.9173578510031;632.9019002054689;638.2118084166051;639.3925770518026;641.8972964325685;643.2955913274957;12167.391630418531;12213.694657633541;12263;12268.079894007897;12290.815637765441;11912.583059592873;12026;12033.037357011419;12225.144239903211;12644.620661380173;9892.901070989343;10390.844137337946;10814.891851081467;10815.67552973412;11018.669439916815;3596.1009747563107;3673.779573225615;3691.446283057536;3700.2599480104086;3780.9054773630605;43149;43276.134477310276;43365.13269734619;43576.3463548047;43830.99999999968;9558.139767420826;9707.369021013612;9767.658131965347;10105.39367637944;10146.594136234615;16869.831301686827;16908.830911690973;16957.915210424115;16991.49025529236;17029.40397086096;7163.7492687755675;7233.0597022386755;7293.70825166998;7455.030845989987;7491.70033198666;4127.422160897477;4175.54069052404;4214.262504061777;4277.529471758104;4320.935185972213;2962.1113665900143;2967.0950360140364;2992.670806211315;3011;3017.7585793136936;621.3382747374033;632.2002666626721;632.3265722006141;648.6983552648041;660.5046215338496;591.5326891755551;601.3865856826101;603.0471854469927;627.4008322052429;647.6988200486796;6947.3747362737595;7047.43620510358;7061.470389720792;7088.716451341992;7174.174969878426;509.8011775407594;512.4593553800702;570.4495162168528;587.7120211096617;613.5582380685988;3732.682721968663;3949.111449923744;4054.959450405458;4085.8559603310528;4103.712740108163;54820.45179548153;57165.71417142971;57477;58381.70809145927;59351.70324148438;47584.7620761894;47826.760866195444;47860.760696196296;53749.462505374446;54946;44775.32837007447;44959;45453.77273113679;45814.31278530825;46201.76899115483;7449.813754656177;7712.035995500562;7745.7676269712;7763.534187948741;7913.723019694283;32565.837170813993;33024.50463243005;33392.1651958703;33452.498212527316;33454.99635010953;39187.21625567415;41573.792131039154;41968.1606367877;42787.57212427836;43455;9318.347715659838;9445.244380449685;10004.149647280063;10100.191984641358;10306.433146177033;11359.659210223706;11389.544418223179;11427.542898283975;11546.13403994687;11888.821667675165;9850.852237216304;10169.9491502542;10239.653579906093;10341.37951722899;10359.741006474898;10326.638567650096;10342.948285258526;10344.120749736358;11522.42387880586;11852.525898963944;9832.459214742972;10257.846132307872;10481.895181048092;10498.842517362398;10509.159267258448;8426.15738426177;8451.45065570736;8661.13388661129;8900.243479304332;9346.672866449642;8024.398170137147;8146.470479418819;8317.293030092509;8384.53885036329;8470.618822153141 23:13:01 INFO - PROCESS | 30358 | __end_tp_report 23:13:01 INFO - PROCESS | 30358 | __start_cc_report 23:13:01 INFO - PROCESS | 30358 | _x_x_mozilla_cycle_collect,301 23:13:01 INFO - PROCESS | 30358 | __end_cc_report 23:13:01 INFO - PROCESS | 30358 | __startTimestamp1451545981711__endTimestamp 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | ------- Summary: start ------- 23:13:01 INFO - PROCESS | 30358 | Number of tests: 6 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#0] dojo.html Cycles:165 Average:5377.83 Median:5608.92 stddev:610.94 (10.9%) stddev-sans-first:585.39 23:13:01 INFO - PROCESS | 30358 | Values: 3070.9 3097.5 3119.3 3120.6 3145.9 5234.3 5296.5 5296.9 5341.0 5348.8 5286.9 5303.5 5332.9 5386.1 5480.9 4896.9 4933.1 4935.9 4997.5 5045.8 4955.8 4965.3 4995.1 5025.8 5030.3 4802.1 4831.7 4890.3 4914.1 4938.4 4844.5 4849.2 4873.7 4877.8 4910.0 4829.5 4850.9 4855.1 4857.8 4866.3 5075.5 5161.1 5168.8 5219.7 5243.4 5720.1 5722.9 5726.4 5744.4 5747.7 5711.4 5779.7 5780.5 5783.2 5800.3 5415.4 5430.2 5505.3 5511.4 5553.3 5963.0 5965.1 5967.3 5983.2 5993.9 5482.6 5597.7 5684.5 5688.7 5704.1 5650.8 5730.3 5740.6 5759.2 5797.3 5757.9 5766.6 5779.3 5803.7 5809.5 5679.7 5682.5 5753.4 5807.4 5840.8 4519.3 4519.8 4526.7 4548.5 4562.3 3989.3 4002.3 4005.7 4030.3 4037.7 5320.3 5362.8 5403.1 5461.9 5510.4 5870.4 5903.4 5917.0 5919.0 5932.6 5445.8 5464.9 5469.0 5477.9 5483.0 4930.5 5021.7 5029.9 5094.3 5136.8 6037.9 6042.8 6046.3 6055.2 6062.5 5622.8 5846.5 5847.6 5869.3 5869.3 5866.4 5875.8 5987.5 5998.0 6042.2 5767.0 5786.0 5787.7 5792.4 5799.9 5608.9 5723.5 5808.6 5867.1 5876.9 5556.7 5571.3 5623.7 5632.5 5665.6 5643.6 5693.7 5702.5 5705.5 5720.7 5509.3 5513.3 5603.7 5616.8 5624.3 5747.3 5806.2 5809.4 5812.2 5838.9 5635.2 5637.7 5668.0 5685.9 5707.6 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#1] ext.html Cycles:180 Average:58614.49 Median:21887.79 stddev:128469.53 (586.9%) stddev-sans-first:128755.88 23:13:01 INFO - PROCESS | 30358 | Values: 522.8 524.9 579.5 580.8 582.2 27427.7 27994.0 36080.6 36645.0 36747.3 39467.0 40146.6 40187.0 40282.6 40353.6 8536.7 8680.2 8720.3 8721.1 8750.4 8430.5 8492.2 8578.9 8586.2 8614.8 8744.2 8792.5 8826.2 8863.6 8921.6 8696.5 8724.8 8800.7 8802.8 8804.0 8545.3 8644.0 8712.8 8717.3 8758.3 39812.4 40022.8 40407.8 40504.6 40643.6 3285.9 3409.2 3457.8 3848.3 3963.2 29412.7 29430.7 29641.0 29876.3 30825.0 3623.6 3634.5 3648.5 3744.9 3756.8 258769.0 260186.0 260190.0 260330.0 260372.0 55746.7 55836.0 55993.0 56212.0 56339.7 60769.0 66983.3 68014.7 68351.0 68428.3 15632.9 15734.4 15850.4 15880.8 15978.3 11711.4 11749.5 11764.0 11774.0 11826.0 20078.7 20388.0 20398.5 20453.3 20534.0 8152.0 8417.5 8428.5 8432.0 8486.8 941.9 979.1 1005.6 1030.6 1122.6 27698.4 29038.6 29234.7 32664.5 33652.0 1066.5 1083.8 1160.6 1163.7 1166.5 15099.2 15338.8 15420.0 15569.2 15600.3 707979.0 721080.0 727452.0 728649.0 729309.0 54059.7 54235.7 54637.0 54780.2 54787.7 1361.2 1389.4 1394.3 1399.8 1409.4 29357.3 30152.2 30651.7 31562.2 31920.5 49098.3 50039.7 50091.2 50112.7 50184.0 302408.0 302458.0 303634.0 304612.0 305388.0 42298.4 42895.8 43173.8 43555.1 43558.8 45629.8 45645.5 46037.0 46678.0 46842.5 37718.2 38653.2 38740.6 39122.2 40269.8 33765.0 38808.8 41697.6 43053.0 44482.6 38755.0 41436.4 41551.8 41760.0 42341.8 28935.0 29430.3 30827.7 31911.7 31940.5 23772.2 24369.0 24457.0 27034.6 27101.3 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#2] jquery.html Cycles:180 Average:27705.61 Median:367.65 stddev:83666.53 (22757.1%) stddev-sans-first:83876.03 23:13:01 INFO - PROCESS | 30358 | Values: 357.4 359.8 367.6 367.7 369.1 16657.3 16981.0 17053.2 17409.6 17459.6 10926.1 11495.4 16230.7 16239.6 16256.6 4788.1 5378.6 5392.6 5398.3 5402.0 5353.9 5426.7 5430.4 5438.3 5438.3 4989.6 5077.5 5146.3 5220.3 5266.5 5184.9 5219.3 5223.9 5283.1 5898.0 5279.9 5291.0 5291.9 5298.7 5305.3 12445.5 13495.5 17862.6 20012.3 20023.6 2103.4 2116.7 2212.5 2238.0 2254.2 9637.1 9638.7 9787.0 12013.7 12602.5 1815.2 1818.1 1822.8 1846.8 1873.5 53022.0 55512.7 58128.4 61806.0 62130.0 9911.0 10211.5 10324.3 10367.0 10388.6 13309.5 13401.0 13412.3 13472.3 13498.6 7756.7 7784.2 7793.8 7807.6 7913.0 7582.5 7633.5 7669.7 7677.7 7695.5 4410.1 4448.0 4480.1 4483.4 4494.2 1834.8 1858.7 1860.7 1877.3 1881.1 851.5 924.9 942.3 958.4 1022.7 15719.3 15744.3 15819.4 16286.8 16365.1 945.9 959.7 968.4 987.1 1037.5 9253.6 9409.4 9564.0 9677.2 9881.3 498921.0 501129.0 507759.0 524126.0 526700.0 78083.8 78158.0 78530.1 79452.2 81039.6 1152.7 1154.8 1209.5 1220.3 1241.3 15726.6 16009.4 16017.2 16052.6 16412.3 34843.3 34919.7 35085.6 35830.2 36104.5 44909.0 46273.5 46587.5 46618.8 46890.3 9330.5 9632.7 9854.5 9868.2 9925.5 11433.3 11463.5 11715.7 11730.6 13633.6 13457.9 13516.7 14053.5 14060.9 14539.9 13672.5 13905.4 14019.8 14095.7 14155.2 14282.2 14504.0 14537.5 14706.4 15055.2 9189.8 9722.2 9856.0 9920.7 9936.5 10147.2 10608.6 14790.9 14833.1 14967.2 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#3] mootools.html Cycles:180 Average:5454.11 Median:6236.28 stddev:2823.73 (45.3%) stddev-sans-first:2815.86 23:13:01 INFO - PROCESS | 30358 | Values: 1480.4 1491.8 1518.5 1572.8 1615.5 7565.2 7695.5 7848.8 7966.3 7994.0 7653.5 7660.1 7731.8 7742.5 7748.8 2267.9 2276.8 2282.5 2314.1 2317.5 2322.9 2347.6 2373.1 2379.5 2380.3 2285.6 2316.4 2349.0 2350.9 2359.9 2287.9 2301.5 2326.3 2328.8 2348.6 2323.7 2363.2 2364.5 2365.5 2365.6 7620.2 7747.1 7755.6 7757.3 7807.8 4773.5 4803.4 4812.4 4830.9 4876.2 3157.8 3182.4 3214.9 3217.4 3225.4 1004.6 1007.9 1025.6 1041.7 1071.1 10863.7 10897.4 10914.1 10943.1 10961.8 4216.7 4333.8 4340.3 4386.9 4427.6 8623.2 8689.7 8690.3 8691.3 8701.4 4688.8 4689.5 4699.7 4718.3 4720.9 4248.5 4269.8 4274.5 4287.6 4297.5 3510.6 3534.9 3546.9 3578.4 3591.3 1137.2 1146.5 1161.5 1169.3 1178.9 1031.1 1036.8 1069.5 1158.1 1291.0 6851.8 6980.3 7023.9 7035.1 7068.1 1037.1 1048.5 1050.6 1113.3 1139.6 5231.4 5294.5 5314.4 5331.8 5333.8 9327.3 9366.7 9547.8 9571.6 9619.4 9386.2 9420.2 9423.5 9478.1 9570.2 7356.6 7377.5 7551.3 7554.8 7581.0 6707.6 6732.8 6750.9 6752.4 6758.9 8279.2 8510.2 8555.4 8608.5 8633.2 8591.4 8754.7 8832.6 8844.2 8865.8 6592.7 6608.8 6773.5 6787.6 6788.7 7571.1 7609.0 7666.3 7669.2 7680.3 6853.3 7110.8 7185.6 7336.4 7343.3 6840.2 6912.3 6951.9 7044.5 7123.9 7104.5 7134.6 7136.5 7157.4 7195.8 6267.1 6308.3 6336.0 6339.6 6350.3 6205.4 6308.7 6337.7 6339.6 6368.1 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#4] prototype.html Cycles:180 Average:5535.03 Median:6198.13 stddev:1661.88 (26.8%) stddev-sans-first:1620.15 23:13:01 INFO - PROCESS | 30358 | Values: 339.9 340.4 341.4 350.2 351.1 6191.4 6200.4 6244.5 6260.4 6354.4 6062.1 6187.4 6188.5 6199.9 6241.3 4769.5 4818.5 4818.5 4824.8 4826.4 4796.7 4803.2 4823.7 4831.0 4845.3 4705.7 4784.6 4798.6 4811.6 4813.3 4784.5 4785.0 4794.7 4802.4 4804.2 4209.2 4218.2 4230.1 4232.1 4242.0 5970.9 5971.1 5983.4 5985.9 5994.8 5444.4 5563.7 5566.7 5598.4 5604.4 6606.0 6614.1 6614.7 6619.3 6630.6 4648.6 4659.4 4660.8 4664.6 4673.9 6702.0 6927.7 6932.1 6947.9 6957.5 4608.4 4672.3 4683.0 4684.8 4689.7 4732.4 4738.9 4745.7 4748.2 4764.8 5490.6 5505.0 5511.6 5524.7 5525.5 6509.2 6676.3 6701.5 6708.4 6714.8 1628.5 1662.3 1664.4 1665.4 1671.2 1099.6 1101.3 1105.3 1110.8 1111.8 6159.4 6194.9 6196.3 6201.7 6213.6 6752.5 6767.6 6768.5 6772.1 6777.8 6074.8 6166.8 6182.9 6187.2 6203.7 3673.9 3682.9 3690.9 3692.7 3706.1 7046.2 7047.9 7055.2 7059.4 7060.5 6806.8 6956.9 6961.8 6975.9 6988.4 6969.5 7045.0 7047.8 7053.8 7064.4 6755.1 6756.2 6766.5 6766.9 6775.6 6586.3 6671.2 6695.2 6707.0 6707.2 6979.1 7017.4 7018.6 7019.6 7023.5 4645.8 4668.0 4668.2 4672.9 4683.5 6728.2 6732.5 6787.8 6802.8 6870.7 6618.5 6656.1 6670.1 6680.2 6685.0 6691.5 6695.5 6700.0 6702.9 6704.2 6431.6 6566.2 6594.3 6601.8 6619.6 6685.1 6725.2 6760.9 6762.8 6775.3 6563.6 6567.8 6602.1 6603.1 6603.3 23:13:01 INFO - PROCESS | 30358 | 23:13:01 INFO - PROCESS | 30358 | [#5] yui.html Cycles:180 Average:13086.98 Median:46008.04 stddev:15416.89 (33.5%) stddev-sans-first:15432.17 23:13:01 INFO - PROCESS | 30358 | Values: 720.0 726.9 738.6 773.8 843.3 12832.5 12845.8 12995.1 12995.5 13066.7 11376.8 11387.0 11406.1 11437.4 11451.1 667.6 677.1 804.6 810.2 814.1 817.1 824.8 831.7 833.3 834.0 847.0 860.2 860.6 862.4 864.5 852.8 864.6 868.2 869.6 869.9 632.9 638.2 639.4 641.9 643.3 12167.4 12213.7 12263.0 12268.1 12290.8 11912.6 12026.0 12033.0 12225.1 12644.6 9892.9 10390.8 10814.9 10815.7 11018.7 3596.1 3673.8 3691.4 3700.3 3780.9 43149.0 43276.1 43365.1 43576.3 43831.0 9558.1 9707.4 9767.7 10105.4 10146.6 16869.8 16908.8 16957.9 16991.5 17029.4 7163.7 7233.1 7293.7 7455.0 7491.7 4127.4 4175.5 4214.3 4277.5 4320.9 2962.1 2967.1 2992.7 3011.0 3017.8 621.3 632.2 632.3 648.7 660.5 591.5 601.4 603.0 627.4 647.7 6947.4 7047.4 7061.5 7088.7 7174.2 509.8 512.5 570.4 587.7 613.6 3732.7 3949.1 4055.0 4085.9 4103.7 54820.5 57165.7 57477.0 58381.7 59351.7 47584.8 47826.8 47860.8 53749.5 54946.0 44775.3 44959.0 45453.8 45814.3 46201.8 7449.8 7712.0 7745.8 7763.5 7913.7 32565.8 33024.5 33392.2 33452.5 33455.0 39187.2 41573.8 41968.2 42787.6 43455.0 9318.3 9445.2 10004.1 10100.2 10306.4 11359.7 11389.5 11427.5 11546.1 11888.8 9850.9 10169.9 10239.7 10341.4 10359.7 10326.6 10342.9 10344.1 11522.4 11852.5 9832.5 10257.8 10481.9 10498.8 10509.2 8426.2 8451.5 8661.1 8900.2 9346.7 8024.4 8146.5 8317.3 8384.5 8470.6 23:13:01 INFO - PROCESS | 30358 | -------- Summary: end -------- 23:13:01 INFO - PROCESS | 30358 | 23:13:02 INFO - TEST-INFO | 30358: exit 0 23:13:02 INFO - TEST-OK | dromaeo_css | took 1110555ms 23:13:02 INFO - TEST-START | kraken 23:13:02 INFO - operating with platform_type : linux_ 23:13:02 INFO - Initialising browser for kraken test... 23:13:02 INFO - TEST-INFO | started process 30605 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpldIySr/profile http://localhost:59165/getInfo.html) 23:13:07 INFO - PROCESS | 30605 | __metrics Screen width/height:1600/1200 23:13:07 INFO - PROCESS | 30605 | colorDepth:24 23:13:07 INFO - PROCESS | 30605 | Browser inner width/height: 1024/697 23:13:07 INFO - PROCESS | 30605 | __metrics 23:13:07 INFO - PROCESS | 30605 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:08 INFO - TEST-INFO | 30605: exit 0 23:13:08 INFO - Browser initialized. 23:13:08 INFO - Running cycle 1/1 for kraken test... 23:13:08 INFO - TEST-INFO | started process 30727 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpldIySr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:19 INFO - PROCESS | 30727 | RSS: Main: 150151168 23:13:19 INFO - PROCESS | 30727 | 23:13:22 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59165/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:23 INFO - PROCESS | 30727 | RSS: Main: 151302144 23:13:23 INFO - PROCESS | 30727 | 23:13:25 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59165/tests/kraken/driver.html?testName=audio-dft) 23:13:26 INFO - PROCESS | 30727 | RSS: Main: 150302720 23:13:26 INFO - PROCESS | 30727 | 23:13:29 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59165/tests/kraken/driver.html?testName=audio-fft) 23:13:29 INFO - PROCESS | 30727 | RSS: Main: 146292736 23:13:29 INFO - PROCESS | 30727 | 23:13:31 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59165/tests/kraken/driver.html?testName=audio-oscillator) 23:13:32 INFO - PROCESS | 30727 | RSS: Main: 146579456 23:13:32 INFO - PROCESS | 30727 | 23:13:34 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:35 INFO - PROCESS | 30727 | RSS: Main: 146829312 23:13:35 INFO - PROCESS | 30727 | 23:13:38 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59165/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:38 INFO - PROCESS | 30727 | RSS: Main: 148328448 23:13:38 INFO - PROCESS | 30727 | 23:13:42 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59165/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:42 INFO - PROCESS | 30727 | RSS: Main: 149471232 23:13:42 INFO - PROCESS | 30727 | 23:13:45 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59165/tests/kraken/driver.html?testName=json-parse-financial) 23:13:46 INFO - PROCESS | 30727 | RSS: Main: 149389312 23:13:46 INFO - PROCESS | 30727 | 23:13:47 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:48 INFO - PROCESS | 30727 | RSS: Main: 149209088 23:13:48 INFO - PROCESS | 30727 | 23:13:50 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:50 INFO - PROCESS | 30727 | RSS: Main: 149053440 23:13:50 INFO - PROCESS | 30727 | 23:13:52 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:53 INFO - PROCESS | 30727 | RSS: Main: 149172224 23:13:53 INFO - PROCESS | 30727 | 23:13:55 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:56 INFO - PROCESS | 30727 | RSS: Main: 148987904 23:13:56 INFO - PROCESS | 30727 | 23:13:59 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:59 INFO - PROCESS | 30727 | RSS: Main: 148615168 23:13:59 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | Cycle 1(1): loaded http://localhost:59165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59165/tests/kraken/driver.html?testName=ai-astar) 23:14:01 INFO - PROCESS | 30727 | RSS: Main: 148328448 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | __start_tp_report 23:14:01 INFO - PROCESS | 30727 | _x_x_mozilla_page_load 23:14:01 INFO - PROCESS | 30727 | _x_x_mozilla_page_load_details 23:14:01 INFO - PROCESS | 30727 | |i|pagename|runs| 23:14:01 INFO - PROCESS | 30727 | |0;ai-astar;111;108;113;111;112;123;112;110;111;112 23:14:01 INFO - PROCESS | 30727 | |1;audio-beat-detection;154;127;150;178;129;158;148;129;166;129 23:14:01 INFO - PROCESS | 30727 | |2;audio-dft;163;164;163;164;162;162;162;163;170;163 23:14:01 INFO - PROCESS | 30727 | |3;audio-fft;74;73;71;76;75;127;72;73;73;73 23:14:01 INFO - PROCESS | 30727 | |4;audio-oscillator;96;97;142;96;97;97;146;96;97;143 23:14:01 INFO - PROCESS | 30727 | |5;imaging-gaussian-blur;111;110;110;109;110;109;110;109;109;110 23:14:01 INFO - PROCESS | 30727 | |6;imaging-darkroom;146;147;147;146;147;148;146;148;147;147 23:14:01 INFO - PROCESS | 30727 | |7;imaging-desaturate;96;96;97;96;96;98;96;97;97;96 23:14:01 INFO - PROCESS | 30727 | |8;json-parse-financial;60;60;59;62;60;60;62;60;57;59 23:14:01 INFO - PROCESS | 30727 | |9;json-stringify-tinderbox;71;71;68;70;70;69;69;69;69;69 23:14:01 INFO - PROCESS | 30727 | |10;stanford-crypto-aes;87;89;90;86;88;92;91;97;87;89 23:14:01 INFO - PROCESS | 30727 | |11;stanford-crypto-ccm;123;126;120;118;123;121;120;121;126;118 23:14:01 INFO - PROCESS | 30727 | |12;stanford-crypto-pbkdf2;140;152;157;167;164;152;151;155;144;142 23:14:01 INFO - PROCESS | 30727 | |13;stanford-crypto-sha256-iterative;70;69;68;72;68;68;70;67;68;68 23:14:01 INFO - PROCESS | 30727 | __end_tp_report 23:14:01 INFO - PROCESS | 30727 | __start_cc_report 23:14:01 INFO - PROCESS | 30727 | _x_x_mozilla_cycle_collect,726 23:14:01 INFO - PROCESS | 30727 | __end_cc_report 23:14:01 INFO - PROCESS | 30727 | __startTimestamp1451546041659__endTimestamp 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | ------- Summary: start ------- 23:14:01 INFO - PROCESS | 30727 | Number of tests: 14 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.00 (3.6%) stddev-sans-first:4.22 23:14:01 INFO - PROCESS | 30727 | Values: 111.0 108.0 113.0 111.0 112.0 123.0 112.0 110.0 111.0 112.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:152.00 stddev:17.87 (11.8%) stddev-sans-first:18.76 23:14:01 INFO - PROCESS | 30727 | Values: 154.0 127.0 150.0 178.0 129.0 158.0 148.0 129.0 166.0 129.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.37 (1.5%) stddev-sans-first:2.50 23:14:01 INFO - PROCESS | 30727 | Values: 163.0 164.0 163.0 164.0 162.0 162.0 162.0 163.0 170.0 163.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#3] audio-fft Cycles:10 Average:78.70 Median:73.00 stddev:17.03 (23.3%) stddev-sans-first:17.98 23:14:01 INFO - PROCESS | 30727 | Values: 74.0 73.0 71.0 76.0 75.0 127.0 72.0 73.0 73.0 73.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.50 stddev:22.77 (23.6%) stddev-sans-first:23.53 23:14:01 INFO - PROCESS | 30727 | Values: 96.0 97.0 142.0 96.0 97.0 97.0 146.0 96.0 97.0 143.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 23:14:01 INFO - PROCESS | 30727 | Values: 111.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 23:14:01 INFO - PROCESS | 30727 | Values: 146.0 147.0 147.0 146.0 147.0 148.0 146.0 148.0 147.0 147.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 23:14:01 INFO - PROCESS | 30727 | Values: 96.0 96.0 97.0 96.0 96.0 98.0 96.0 97.0 97.0 96.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:1.45 (2.4%) stddev-sans-first:1.54 23:14:01 INFO - PROCESS | 30727 | Values: 60.0 60.0 59.0 62.0 60.0 60.0 62.0 60.0 57.0 59.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 23:14:01 INFO - PROCESS | 30727 | Values: 71.0 71.0 68.0 70.0 70.0 69.0 69.0 69.0 69.0 69.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:89.50 stddev:3.20 (3.6%) stddev-sans-first:3.26 23:14:01 INFO - PROCESS | 30727 | Values: 87.0 89.0 90.0 86.0 88.0 92.0 91.0 97.0 87.0 89.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:2.88 (2.4%) stddev-sans-first:3.00 23:14:01 INFO - PROCESS | 30727 | Values: 123.0 126.0 120.0 118.0 123.0 121.0 120.0 121.0 126.0 118.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.50 stddev:8.88 (5.8%) stddev-sans-first:8.21 23:14:01 INFO - PROCESS | 30727 | Values: 140.0 152.0 157.0 167.0 164.0 152.0 151.0 155.0 144.0 142.0 23:14:01 INFO - PROCESS | 30727 | 23:14:01 INFO - PROCESS | 30727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.48 (2.2%) stddev-sans-first:1.50 23:14:01 INFO - PROCESS | 30727 | Values: 70.0 69.0 68.0 72.0 68.0 68.0 70.0 67.0 68.0 68.0 23:14:01 INFO - PROCESS | 30727 | -------- Summary: end -------- 23:14:01 INFO - PROCESS | 30727 | 23:14:02 INFO - TEST-INFO | 30727: exit 0 23:14:02 INFO - TEST-OK | kraken | took 60145ms 23:14:02 INFO - TEST-START | v8_7 23:14:02 INFO - operating with platform_type : linux_ 23:14:02 INFO - Initialising browser for v8_7 test... 23:14:02 INFO - TEST-INFO | started process 31012 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOdlMYc/profile http://localhost:59165/getInfo.html) 23:14:07 INFO - PROCESS | 31012 | __metrics Screen width/height:1600/1200 23:14:07 INFO - PROCESS | 31012 | colorDepth:24 23:14:07 INFO - PROCESS | 31012 | Browser inner width/height: 1024/697 23:14:07 INFO - PROCESS | 31012 | __metrics 23:14:07 INFO - PROCESS | 31012 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:08 INFO - TEST-INFO | 31012: exit 0 23:14:08 INFO - Browser initialized. 23:14:08 INFO - Running cycle 1/1 for v8_7 test... 23:14:08 INFO - TEST-INFO | started process 31137 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOdlMYc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:20 INFO - PROCESS | 31137 | RSS: Main: 150695936 23:14:20 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | Cycle 1(1): loaded http://localhost:59165/tests/v8_7/run.html (next: http://localhost:59165/tests/v8_7/run.html) 23:14:41 INFO - PROCESS | 31137 | RSS: Main: 146841600 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | __start_tp_report 23:14:41 INFO - PROCESS | 31137 | _x_x_mozilla_page_load 23:14:41 INFO - PROCESS | 31137 | _x_x_mozilla_page_load_details 23:14:41 INFO - PROCESS | 31137 | |i|pagename|runs| 23:14:41 INFO - PROCESS | 31137 | |0;Richards;166.27868307283006 23:14:41 INFO - PROCESS | 31137 | |1;DeltaBlue;188.71485185884129 23:14:41 INFO - PROCESS | 31137 | |2;Encrypt;279.6420581655481 23:14:41 INFO - PROCESS | 31137 | |3;Decrypt;5251.308900523561 23:14:41 INFO - PROCESS | 31137 | |4;RayTrace;1075.268817204301 23:14:41 INFO - PROCESS | 31137 | |5;Earley;710.4329311568488 23:14:41 INFO - PROCESS | 31137 | |6;Boyer;12280.487804878048 23:14:41 INFO - PROCESS | 31137 | |7;RegExp;25525 23:14:41 INFO - PROCESS | 31137 | |8;Splay;656.1679790026246 23:14:41 INFO - PROCESS | 31137 | |9;NavierStokes;4835.748792270531 23:14:41 INFO - PROCESS | 31137 | __end_tp_report 23:14:41 INFO - PROCESS | 31137 | __startTimestamp1451546081888__endTimestamp 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | ------- Summary: start ------- 23:14:41 INFO - PROCESS | 31137 | Number of tests: 10 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 166.3 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#1] DeltaBlue Cycles:1 Average:188.71 Median:188.71 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 188.7 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 279.6 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 5251.3 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 1075.3 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#5] Earley Cycles:1 Average:710.43 Median:710.43 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 710.4 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 12280.5 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 25525.0 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#8] Splay Cycles:1 Average:656.17 Median:656.17 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 656.2 23:14:41 INFO - PROCESS | 31137 | 23:14:41 INFO - PROCESS | 31137 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:14:41 INFO - PROCESS | 31137 | Values: 4835.7 23:14:41 INFO - PROCESS | 31137 | -------- Summary: end -------- 23:14:41 INFO - PROCESS | 31137 | 23:14:42 INFO - TEST-INFO | 31137: exit 0 23:14:42 INFO - TEST-OK | v8_7 | took 40179ms 23:14:42 INFO - SUITE-END | took 1210s 23:14:42 INFO - Completed test suite (00:20:11) 23:14:42 INFO - Working with test: dromaeo_css 23:14:42 INFO - Generating results file: dromaeo_css 23:14:42 INFO - Working with test: kraken 23:14:42 INFO - Generating results file: kraken 23:14:42 INFO - javascript benchmark 23:14:42 INFO - Working with test: v8_7 23:14:42 INFO - Generating results file: v8_7 23:14:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:14:42 INFO - process_Request line: dromaeo_css 7042.68 graph.html#tests=[[72,64,43]] 23:14:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:42 INFO - process_Request line: kraken 1527.00 graph.html#tests=[[232,64,43]] 23:14:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:43 INFO - process_Request line: v8_7 21138.47 graph.html#tests=[[230,64,43]] 23:14:43 INFO - RETURN: dromaeo_css: 7042.68 23:14:43 INFO - RETURN: kraken: 1527.00 23:14:43 INFO - RETURN: v8_7: 21138.47 23:14:43 INFO - javascript benchmark 23:14:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3070.9385812283754, 3097.495259954095, 3119.3449375631117, 3120.6411262704796, 3145.9461080538013, 5234.319538459995, 5296.496832800887, 5296.89406211876, 5340.973295133528, 5348.759305831237, 5286.920696189561, 5303.549198318147, 5332.866678333044, 5386.111291636885, 5480.91778623321, 4896.853094407174, 4933.136701077315, 4935.851924442254, 4997.50024997501, 5045.772940217681, 4955.801767929279, 4965.280034395028, 4995.100881841267, 5025.773840177182, 5030.2957585938, 4802.111609352263, 4831.710097394168, 4890.315355850184, 4914.0908931847725, 4938.358013458227, 4844.539768721966, 4849.199882019462, 4873.731944743037, 4877.780499877514, 4910.0, 4829.541193586604, 4850.902981940341, 4855.126077306083, 4857.8299759508245, 4866.294387313855, 5075.543201111881, 5161.096808058574, 5168.767405466763, 5219.686818790885, 5243.449437809051, 5720.141978703186, 5722.914156287659, 5726.427357264281, 5744.396838331999, 5747.655140691572, 5711.428857114297, 5779.739911703983, 5780.450857168562, 5783.21926539916, 5800.274965629296, 5415.377231618375, 5430.212619170198, 5505.3393592768725, 5511.3937466878615, 5553.278073850414, 5963.0, 5965.105234214902, 5967.343592204854, 5983.222181116427, 5993.850153746104, 5482.5613950883835, 5597.720113994284, 5684.54523638108, 5688.687122208318, 5704.1443783432815, 5650.830475085754, 5730.255066841284, 5740.6268592541355, 5759.1649210865025, 5797.275340582427, 5757.8560535986935, 5766.596338256366, 5779.335376431764, 5803.738831752581, 5809.50619197373, 5679.659220446786, 5682.460166284196, 5753.424657534213, 5807.390224026501, 5840.795572154954, 4519.344695019204, 4519.7740112994215, 4526.660500462479, 4548.499665036843, 4562.315652652129, 3989.2819292527042, 4002.2595819772855, 4005.679545636342, 4030.2946984277633, 4037.6971727120585, 5320.281761962163, 5362.758675859595, 5403.13549832025, 5461.918071228855, 5510.393856675762, 5870.383609720918, 5903.35063143054, 5916.970415147896, 5919.0, 5932.614380065282, 5445.809396671098, 5464.9453505464435, 5469.042917489423, 5477.890442191134, 5483.040467918098, 4930.482299358588, 5021.6735912165595, 5029.899402011939, 5094.286799848024, 5136.845894623168, 6037.879242415215, 6042.848928776728, 6046.27444706638, 6055.243094613262, 6062.484688801501, 5622.7750889963945, 5846.532277417881, 5847.649141051551, 5869.266341707286, 5869.325027621708, 5866.413358664099, 5875.794347197828, 5987.520998320211, 5998.040313549811, 6042.244719410074, 5767.0, 5786.0, 5787.710614469175, 5792.362840087671, 5799.884002320015, 5608.915866262091, 5723.513501352431, 5808.593398462067, 5867.149263356875, 5876.941230587639, 5556.749946252347, 5571.331440227036, 5623.746931388016, 5632.521235694848, 5665.5750818689585, 5643.576731745054, 5693.686847223276, 5702.45826646468, 5705.515031222392, 5720.685362305113, 5509.256250406304, 5513.3108361454815, 5603.663780173202, 5616.803411880564, 5624.29696287964, 5747.281589801275, 5806.187133801187, 5809.448102430262, 5812.21535092757, 5838.912416313674, 5635.211070450222, 5637.689927054052, 5668.0, 5685.943140568541, 5707.571932105026], "unit": "score", "name": "dojo.html", "value": 5336.630545969011}, {"lowerIsBetter": false, "replicates": [522.8353068783331, 524.879277766114, 579.4726798613261, 580.834462178279, 582.2169182449605, 27427.725722742765, 27994.0, 36080.639193608054, 36645.0, 36747.26505469889, 39467.0, 40146.59853401465, 40187.0, 40282.59717402825, 40353.59646403542, 8536.74389768308, 8680.175383338572, 8720.258778003878, 8721.12788721129, 8750.3874728769, 8430.5363205024, 8492.235698787108, 8578.914210857905, 8586.184312490303, 8614.784630384227, 8744.213020828125, 8792.47245165289, 8826.205641492264, 8863.556822158898, 8921.59852806622, 8696.521691307007, 8724.825503489927, 8800.73597792064, 8802.779930501725, 8804.031556528776, 8545.316374690072, 8644.005939316996, 8712.825743485095, 8717.259032982203, 8758.343124265642, 39812.402813957815, 40022.799886000386, 40407.7979610103, 40504.59495405038, 40643.59356406428, 3285.8685652573868, 3409.1817963688786, 3457.844397002141, 3848.268828922524, 3963.1677347757004, 29412.70587294121, 29430.70569294301, 29641.0, 29876.253093672614, 30825.0, 3623.565172179329, 3634.4730014148063, 3648.5074514940407, 3744.8689295874515, 3756.8309426075893, 258769.0, 260186.0, 260190.0, 260330.0, 260372.0, 55746.72126639341, 55836.0, 55993.0, 56212.0, 56339.71830140823, 60769.0, 66983.33016669868, 68014.65992670105, 68351.0, 68428.31571684219, 15632.92183539075, 15734.449294274646, 15850.44523441674, 15880.761788573182, 15978.280977356048, 11711.355875426932, 11749.530018799323, 11764.0, 11774.0, 11826.0, 20078.69881951772, 20388.0, 20398.490037749176, 20453.2841350552, 20534.0, 8152.0, 8417.494950303002, 8428.536430496259, 8432.030316513557, 8486.787830304169, 941.9105185007413, 979.1139019187647, 1005.6228914157191, 1030.5723124903232, 1122.646366394583, 27698.446031079264, 29038.564421533694, 29234.707652923626, 32664.510032349535, 33652.0, 1066.4987455895716, 1083.815751322277, 1160.6344001639457, 1163.6974386659529, 1166.521726092315, 15099.169545674873, 15338.846611533965, 15420.0, 15569.221538923008, 15600.29798659063, 707979.0, 721080.0, 727452.0, 728649.0, 729309.0, 54059.72970135203, 54235.72882135564, 54637.0, 54780.17829732557, 54787.72606136944, 1361.2309045389322, 1389.3747813483972, 1394.268009295108, 1399.846016938136, 1409.3587417724912, 29357.26606834846, 30152.24619384445, 30651.693483064882, 31562.210944726565, 31920.52119218167, 49098.26352604642, 50039.749801250764, 50091.24863126983, 50112.74943625258, 50184.0, 302408.0, 302458.0, 303634.0, 304612.0, 305388.0, 42298.36552451777, 42895.7855210722, 43173.78413107914, 43555.12889742251, 43558.78220608877, 45629.77185114053, 45645.54354456413, 46037.0, 46678.0, 46842.53157468382, 37718.2456350877, 38653.226935460574, 38740.61259387483, 39122.217555649295, 40269.79865100656, 33764.987050388525, 38808.80595597004, 41697.58302416937, 43053.0, 44482.55517444784, 38755.0, 41436.378454323814, 41551.79224103981, 41760.0, 42341.78829105958, 28935.0, 29430.26424339323, 30827.691723082484, 31911.68088319087, 31940.5208921871, 23772.167974120825, 24369.0, 24457.0, 27034.594481083193, 27101.322466938484], "unit": "score", "name": "ext.html", "value": 19440.095349041323}, {"lowerIsBetter": false, "replicates": [357.4495277273, 359.78592737321287, 367.6305313160274, 367.6709345136103, 369.0588998054959, 16657.25042373093, 16981.0, 17053.232604532794, 17409.564760880985, 17459.563510912234, 10926.071283940875, 11495.367754773504, 16230.675386492263, 16239.594010149753, 16256.593585160377, 4788.138135135683, 5378.596605254602, 5392.622516423852, 5398.271233383502, 5402.0, 5353.892922141555, 5426.728663566825, 5430.3755068167075, 5438.293021907147, 5438.3473983121885, 4989.625778066641, 5077.466865979056, 5146.305248791403, 5220.29526013987, 5266.4733526647415, 5184.937087896972, 5219.347581552287, 5223.895522089556, 5283.101872681634, 5898.0, 5279.947200527984, 5290.973545132289, 5291.86770330741, 5298.682079075268, 5305.283786688786, 12445.502179912794, 13495.527656532073, 17862.55343616407, 20012.299569515144, 20023.599528009505, 2103.3689893032183, 2116.6719158530454, 2212.513247085639, 2238.0488292475634, 2254.211026140854, 9637.132658060807, 9638.710838674851, 9787.0, 12013.699657508545, 12602.495900163982, 1815.1831675745834, 1818.0546116019727, 1822.7903791064066, 1846.8245516675895, 1873.4754268804757, 53022.0, 55512.722436387965, 58128.418715812724, 61806.0, 62130.0, 9910.950445247872, 10211.489425528694, 10324.328918620266, 10367.0, 10388.584456621651, 13309.467621295233, 13401.0, 13412.262325571992, 13472.326383680776, 13498.595042148554, 7756.6509507072315, 7784.2215778421705, 7793.844123117619, 7807.570583617956, 7912.971313729178, 7582.54504729707, 7633.503822251536, 7669.654865531064, 7677.731279405194, 7695.461317707706, 4410.051838854662, 4447.955520444754, 4480.059187570581, 4483.394741709827, 4494.213512635276, 1834.7981722010568, 1858.6840237159715, 1860.6557786809483, 1877.2866310801808, 1881.0688709089088, 851.4720873058743, 924.8658944453017, 942.2838642631513, 958.4009993753904, 1022.7340891368298, 15719.292631831595, 15744.291506882219, 15819.446319378767, 16286.755698664529, 16365.099919504304, 945.9148676619, 959.6785076999143, 968.3608818179968, 987.1206159791943, 1037.5382954585136, 9253.583588738524, 9409.388389754644, 9563.952180239054, 9677.22582193437, 9881.25890558211, 498921.0, 501129.0, 507759.0, 524126.0, 526700.0, 78083.8287425689, 78158.0, 78530.1102417321, 79452.20547794564, 81039.59480202562, 1152.7002979225463, 1154.786364522566, 1209.4920133543933, 1220.2922305063041, 1241.2986662535639, 15726.606834829221, 16009.439669611507, 16017.199140042718, 16052.598685032968, 16412.343506259615, 34843.30313393768, 34919.65080349164, 35085.649143508235, 35830.20848957489, 36104.45843312405, 44909.0, 46273.537264626924, 46587.53412465832, 46618.76690616525, 46890.296645551025, 9330.533473326443, 9632.662856799978, 9854.507274636097, 9868.210543156674, 9925.503724813587, 11433.256838305484, 11463.541458341573, 11715.707107322045, 11730.589429369931, 13633.590992270249, 13457.865421345661, 13516.6620834476, 14053.45412004699, 14060.859391405955, 14539.854601454274, 13672.453101875813, 13905.443782249002, 14019.789703154256, 14095.718085638026, 14155.150690958164, 14282.2144782038, 14504.0, 14537.491187808377, 14706.41174353014, 15055.171965541562, 9189.77025574366, 9722.222222222346, 9856.0, 9920.652777153055, 9936.503174841084, 10147.188224942134, 10608.628697995533, 14790.926045369704, 14833.110013399231, 14967.176805275814], "unit": "score", "name": "jquery.html", "value": 8745.328517509339}, {"lowerIsBetter": false, "replicates": [1480.4004378226819, 1491.8284397294315, 1518.5292559306615, 1572.787673664055, 1615.450746746106, 7565.167831538526, 7695.5382677039415, 7848.764537063883, 7966.283034526891, 7993.999999999993, 7653.502522336044, 7660.119086305062, 7731.7680469586, 7742.458027938046, 7748.845023099549, 2267.875266860322, 2276.7837055479786, 2282.5206706591634, 2314.109068008812, 2317.536492701458, 2322.8954697038675, 2347.5539647467012, 2373.098222675381, 2379.4765151666606, 2380.2502211803226, 2285.5771682238756, 2316.4324740438615, 2348.9530209395803, 2350.8707021113833, 2359.8938047787806, 2287.874166920819, 2301.470661747799, 2326.2904814031713, 2328.7787660172257, 2348.6477028445697, 2323.6979192705007, 2363.196513185508, 2364.5270945810908, 2365.491419344849, 2365.562370961378, 7620.237976202336, 7747.147813740484, 7755.612219389008, 7757.301842834116, 7807.765767026942, 4773.546513081252, 4803.423589169287, 4812.374391329105, 4830.85507434774, 4876.195427754452, 3157.8263195524237, 3182.427163110639, 3214.9357012859614, 3217.3565286942703, 3225.4194245035883, 1004.5529739266029, 1007.89417111203, 1025.5538840604286, 1041.666666666667, 1071.0788721699332, 10863.67408977724, 10897.400642964712, 10914.126869850394, 10943.124550036058, 10961.84900585443, 4216.746995180299, 4333.804978775963, 4340.305551111807, 4386.934195987063, 4427.645788336989, 8623.223909848019, 8689.739307820775, 8690.304775617935, 8691.261242794308, 8701.390902636755, 4688.8124475021295, 4689.531046895283, 4699.671023028355, 4718.339432479455, 4720.929186062212, 4248.468941382327, 4269.847141271839, 4274.487061552633, 4287.614114729689, 4297.484301883794, 3510.648935106469, 3534.8511733686655, 3546.858125674996, 3578.4274516077303, 3591.2996965591983, 1137.181229514748, 1146.4726225936163, 1161.506359797083, 1169.316184694038, 1178.9233699809486, 1031.1080915008613, 1036.8133735927454, 1069.4599227390117, 1158.1256151605485, 1290.9548165814151, 6851.760188393382, 6980.336867997532, 7023.89464158038, 7035.050268213828, 7068.0811494506415, 1037.113268155731, 1048.5386429970788, 1050.6060227414719, 1113.33200079953, 1139.6239241050434, 5231.372235331784, 5294.523492885659, 5314.362276526842, 5331.840044798662, 5333.839984800462, 9327.300452465957, 9366.672166474276, 9547.809043819085, 9571.61713531451, 9619.374740641835, 9386.155246027754, 9420.152186303128, 9423.528823558794, 9478.099580539838, 9570.234381249484, 7356.595387253646, 7377.5204611700065, 7551.320381165721, 7554.848903022019, 7581.0, 6707.631080290631, 6732.831679208059, 6750.898736518858, 6752.3922846944015, 6758.898616520854, 8279.172082791672, 8510.234078932926, 8555.35834812404, 8608.48349099056, 8633.179847914438, 8591.355648326275, 8754.69358572447, 8832.5583720815, 8844.248238899509, 8865.822683546421, 6592.736290548324, 6608.801735947929, 6773.525853190229, 6787.62668053242, 6788.7284508619105, 7571.053618297713, 7609.048868891388, 7666.310032097138, 7669.233076692286, 7680.3471704905705, 6853.280405557344, 7110.822229444305, 7185.604791736296, 7336.449766267658, 7343.3390994810725, 6840.213375461686, 6912.343327383891, 6951.8609627806145, 7044.542104763174, 7123.931410288498, 7104.467164962545, 7134.571925684476, 7136.500444968802, 7157.355837974607, 7195.784126476214, 6267.122602835698, 6308.27454842699, 6336.017917222838, 6339.619622822645, 6350.333215012542, 6205.441510264098, 6308.684565771785, 6337.7148028337915, 6339.5562310637815, 6368.140301059298], "unit": "score", "name": "mootools.html", "value": 4486.84437680987}, {"lowerIsBetter": false, "replicates": [339.8844392906412, 340.4008944258105, 341.4400383371273, 350.19105865450797, 351.0836716170794, 6191.442770150686, 6200.441960223579, 6244.500439964803, 6260.436560709535, 6354.396332348431, 6062.060380640996, 6187.381261873822, 6188.5358598105095, 6199.907001394983, 6241.3134555199, 4769.499202583731, 4818.494058123882, 4818.494058123882, 4824.831130910419, 4826.372571565709, 4796.688215266014, 4803.207470767319, 4823.686460380081, 4831.0, 4845.273209018657, 4705.670603057787, 4784.641151913603, 4798.592119669832, 4811.639127065467, 4813.278008298766, 4784.473707892146, 4785.042991401716, 4794.664373493857, 4802.399700037496, 4804.20730579454, 4209.200251952119, 4218.2196293685765, 4230.090530535918, 4232.132412855357, 4242.045539753562, 5970.910436343458, 5971.134185543072, 5983.401659834025, 5985.880282394328, 5994.7901823436405, 5444.428335024805, 5563.721813909288, 5566.693831839248, 5598.356189038232, 5604.3835178130375, 6605.966970165118, 6614.140161778938, 6614.669266536702, 6619.271880093186, 6630.569013014187, 4648.581627653527, 4659.4175728034, 4660.836870709542, 4664.580187783115, 4673.929891051637, 6701.966490167518, 6927.653617319113, 6932.064171336855, 6947.861042779166, 6957.5129740918155, 4608.3778689876435, 4672.275797251432, 4682.993156471375, 4684.81260749573, 4689.742064186503, 4732.38478997735, 4738.857834264978, 4745.691530050535, 4748.216544270157, 4764.761761911891, 5490.56075513958, 5505.0, 5511.614187006871, 5524.729312258203, 5525.475079867487, 6509.1863517060365, 6676.332366763285, 6701.530892837454, 6708.42978346846, 6714.832129196711, 1628.51958672192, 1662.2686018151974, 1664.4257731082757, 1665.350513299814, 1671.2061770659084, 1099.6371197504964, 1101.3281898042187, 1105.3147048829776, 1110.777844431117, 1111.8109921313396, 6159.384061593805, 6194.915889719371, 6196.349383314687, 6201.658908760061, 6213.627182369072, 6752.527323087336, 6767.627780472023, 6768.492363072789, 6772.119624448888, 6777.830554236085, 6074.787382441594, 6166.784162554289, 6182.938170618326, 6187.226596675416, 6203.6587987660205, 3673.8897833065053, 3682.8710995115043, 3690.944635830465, 3692.7230457715777, 3706.129059670975, 7046.224915259318, 7047.92952070483, 7055.188653304833, 7059.435245180373, 7060.470464715167, 6806.8298292542095, 6956.8956465653055, 6961.82595435108, 6975.8604827903155, 6988.37104660583, 6969.54697944632, 7044.964775176091, 7047.788566343121, 7053.753118640823, 7064.43484521237, 6755.121834161724, 6756.155480564929, 6766.5263431559315, 6766.93233067663, 6775.559588626724, 6586.2755096940255, 6671.232808226922, 6695.196576410862, 6707.0, 6707.195136583641, 6979.127609048869, 7017.350922533303, 7018.5788852669, 7019.6490175492045, 7023.543469674455, 4645.814167433265, 4667.953320466888, 4668.2297420926525, 4672.883177920579, 4683.4614019386845, 6728.158980127484, 6732.461403087644, 6787.796366109024, 6802.82992925161, 6870.690818913061, 6618.536702430783, 6656.068150459037, 6670.066190733398, 6680.198376194888, 6684.966575167093, 6691.498137639794, 6695.4978376620975, 6699.9665001674675, 6702.932970670231, 6704.229013663296, 6431.646259455775, 6566.179227596551, 6594.307597702172, 6601.801945941629, 6619.569727967667, 6685.130932978682, 6725.159355080615, 6760.898586521108, 6762.830929226612, 6775.288594697486, 6563.638999855054, 6567.835804104936, 6602.10871532337, 6603.108580341593, 6603.306652801387], "unit": "score", "name": "prototype.html", "value": 4989.7773890855815}, {"lowerIsBetter": false, "replicates": [720.0, 726.8909663550467, 738.6491416577123, 773.760134358349, 843.2621456225802, 12832.48670053198, 12845.807312890314, 12995.090343675947, 12995.480180792756, 13066.738665226701, 11376.772464550704, 11387.032102271316, 11406.087512998962, 11437.42812859358, 11451.141164412682, 667.5961043568644, 677.0926957876444, 804.6338915793315, 810.2019510781876, 814.071957967917, 817.1134319263606, 824.8061705499202, 831.6964308027586, 833.3458235285302, 833.9708110216113, 846.9915300846974, 860.1785295043219, 860.6299291304767, 862.4006315610653, 864.4899509289518, 852.799592095857, 864.6195673903494, 868.192580899763, 869.5652173913044, 869.9173578510031, 632.9019002054689, 638.2118084166051, 639.3925770518026, 641.8972964325685, 643.2955913274957, 12167.391630418531, 12213.694657633541, 12263.0, 12268.079894007897, 12290.815637765441, 11912.583059592873, 12026.0, 12033.037357011419, 12225.144239903211, 12644.620661380173, 9892.901070989343, 10390.844137337946, 10814.891851081467, 10815.67552973412, 11018.669439916815, 3596.1009747563107, 3673.779573225615, 3691.446283057536, 3700.2599480104086, 3780.9054773630605, 43149.0, 43276.134477310276, 43365.13269734619, 43576.3463548047, 43830.99999999968, 9558.139767420826, 9707.369021013612, 9767.658131965347, 10105.39367637944, 10146.594136234615, 16869.831301686827, 16908.830911690973, 16957.915210424115, 16991.49025529236, 17029.40397086096, 7163.7492687755675, 7233.0597022386755, 7293.70825166998, 7455.030845989987, 7491.70033198666, 4127.422160897477, 4175.54069052404, 4214.262504061777, 4277.529471758104, 4320.935185972213, 2962.1113665900143, 2967.0950360140364, 2992.670806211315, 3011.0, 3017.7585793136936, 621.3382747374033, 632.2002666626721, 632.3265722006141, 648.6983552648041, 660.5046215338496, 591.5326891755551, 601.3865856826101, 603.0471854469927, 627.4008322052429, 647.6988200486796, 6947.3747362737595, 7047.43620510358, 7061.470389720792, 7088.716451341992, 7174.174969878426, 509.8011775407594, 512.4593553800702, 570.4495162168528, 587.7120211096617, 613.5582380685988, 3732.682721968663, 3949.111449923744, 4054.959450405458, 4085.8559603310528, 4103.712740108163, 54820.45179548153, 57165.71417142971, 57477.0, 58381.70809145927, 59351.70324148438, 47584.7620761894, 47826.760866195444, 47860.760696196296, 53749.462505374446, 54946.0, 44775.32837007447, 44959.0, 45453.77273113679, 45814.31278530825, 46201.76899115483, 7449.813754656177, 7712.035995500562, 7745.7676269712, 7763.534187948741, 7913.723019694283, 32565.837170813993, 33024.50463243005, 33392.1651958703, 33452.498212527316, 33454.99635010953, 39187.21625567415, 41573.792131039154, 41968.1606367877, 42787.57212427836, 43455.0, 9318.347715659838, 9445.244380449685, 10004.149647280063, 10100.191984641358, 10306.433146177033, 11359.659210223706, 11389.544418223179, 11427.542898283975, 11546.13403994687, 11888.821667675165, 9850.852237216304, 10169.9491502542, 10239.653579906093, 10341.37951722899, 10359.741006474898, 10326.638567650096, 10342.948285258526, 10344.120749736358, 11522.42387880586, 11852.525898963944, 9832.459214742972, 10257.846132307872, 10481.895181048092, 10498.842517362398, 10509.159267258448, 8426.15738426177, 8451.45065570736, 8661.13388661129, 8900.243479304332, 9346.672866449642, 8024.398170137147, 8146.470479418819, 8317.293030092509, 8384.53885036329, 8470.618822153141], "unit": "score", "name": "yui.html", "value": 6006.558637461515}], "name": "dromaeo_css", "value": 7042.683588424286}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 113.0, 111.0, 112.0, 123.0, 112.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 150.0, 178.0, 129.0, 158.0, 148.0, 129.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 162.0, 162.0, 162.0, 163.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 71.0, 76.0, 75.0, 127.0, 72.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 142.0, 96.0, 97.0, 97.0, 146.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 62.0, 60.0, 60.0, 62.0, 60.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 68.0, 70.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [87.0, 89.0, 90.0, 86.0, 88.0, 92.0, 91.0, 97.0, 87.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.6}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 120.0, 118.0, 123.0, 121.0, 120.0, 121.0, 126.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 157.0, 167.0, 164.0, 152.0, 151.0, 155.0, 144.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.4}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 72.0, 68.0, 68.0, 70.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1527.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [188.71485185884129], "unit": "score", "name": "DeltaBlue", "value": 350.35928200000006}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [710.4329311568488], "unit": "score", "name": "Earley", "value": 938.1082587412584}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [656.1679790026246], "unit": "score", "name": "Splay", "value": 124.19228399999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21138.465480144623}]} 23:14:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21138.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7042.68"}}} 23:14:43 INFO - Return code: 0 23:14:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:43 INFO - # TBPL SUCCESS # 23:14:43 INFO - Running post-action listener: _resource_record_post_action 23:14:43 INFO - Running post-run listener: _resource_record_post_run 23:14:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554905600; Read time: 100; Write time: 466184 23:14:44 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235278336; Read time: 0; Write time: 258612 23:14:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319627264; Read time: 100; Write time: 207572 23:14:44 INFO - Running post-run listener: _upload_blobber_files 23:14:44 INFO - Blob upload gear active. 23:14:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:44 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 23:14:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:14:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:14:44 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:45 INFO - (blobuploader) - INFO - Done attempting. 23:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:46 INFO - (blobuploader) - INFO - Done attempting. 23:14:46 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:46 INFO - Return code: 0 23:14:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c6f3fc22e94002ea1e9a7712879a3da1fda4bad1cb4bdcb8b371cede6db2857f6bcd82231fea6adb01e0e65defa50956b6a449b638345bac4b16116c926610d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da33ffdade526fb5a7068d7deedf8bfca62a4201de296e64d337a4ecbc10615426deef1e34db11596ef460707e7f17d404ff10fd25a9789e1e00c7e2e8c0c00"} 23:14:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:46 INFO - Contents: 23:14:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c6f3fc22e94002ea1e9a7712879a3da1fda4bad1cb4bdcb8b371cede6db2857f6bcd82231fea6adb01e0e65defa50956b6a449b638345bac4b16116c926610d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da33ffdade526fb5a7068d7deedf8bfca62a4201de296e64d337a4ecbc10615426deef1e34db11596ef460707e7f17d404ff10fd25a9789e1e00c7e2e8c0c00"} 23:14:46 INFO - Copying logs to upload dir... 23:14:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.817286 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-30 23:14:45.682533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 23:14:45.686467) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c6f3fc22e94002ea1e9a7712879a3da1fda4bad1cb4bdcb8b371cede6db2857f6bcd82231fea6adb01e0e65defa50956b6a449b638345bac4b16116c926610d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da33ffdade526fb5a7068d7deedf8bfca62a4201de296e64d337a4ecbc10615426deef1e34db11596ef460707e7f17d404ff10fd25a9789e1e00c7e2e8c0c00"} build_url:https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/H02boSwrTuGXXraBKgm7kw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c6f3fc22e94002ea1e9a7712879a3da1fda4bad1cb4bdcb8b371cede6db2857f6bcd82231fea6adb01e0e65defa50956b6a449b638345bac4b16116c926610d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8da33ffdade526fb5a7068d7deedf8bfca62a4201de296e64d337a4ecbc10615426deef1e34db11596ef460707e7f17d404ff10fd25a9789e1e00c7e2e8c0c00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 23:14:45.710499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 23:14:45.710883) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7f67ac1ceef7774224e327f2000001f6-1451543743.798622-2004085317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004677 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 23:14:45.796866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 23:14:45.797187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 23:14:45.797499) ========= ========= Total master_lag: 0.30 =========