builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1452106590.57 results: success (0) buildid: 20160106083214 builduid: b049be186d3346f68008e9346eb4c3d5 revision: c1959d17af7cb8048f48c71727fcea8b9fcf17ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.571972) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.572642) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.572930) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.599174) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.599466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.661427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.661712) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.739787) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.740085) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.740468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.740756) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 10:56:31-- 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.6M=0s 2016-01-06 10:56:32 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.856979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.857267) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017185 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.942810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:30.943123) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1959d17af7cb8048f48c71727fcea8b9fcf17ae --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 c1959d17af7cb8048f48c71727fcea8b9fcf17ae --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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 10:56:32,181 truncating revision to first 12 chars 2016-01-06 10:56:32,181 Setting DEBUG logging. 2016-01-06 10:56:32,181 attempt 1/10 2016-01-06 10:56:32,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1959d17af7c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 10:56:32,406 unpacking tar archive at: fx-team-c1959d17af7c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:31.471902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:31.472168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:31.482163) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:31.482414) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 10:56:31.482775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-06 10:56:31.483054) ========= /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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:32 INFO - MultiFileLogger online at 20160106 10:56:32 in /builds/slave/test-pgo 10:56:32 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 10:56:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:56:32 INFO - {'append_to_log': False, 10:56:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:56:32 INFO - 'blob_upload_branch': 'Fx-Team', 10:56:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:56:32 INFO - 'branch': 'Fx-Team', 10:56:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:32 INFO - 'config_files': ('talos/linux_config.py',), 10:56:32 INFO - 'default_actions': ('clobber', 10:56:32 INFO - 'read-buildbot-config', 10:56:32 INFO - 'download-and-extract', 10:56:32 INFO - 'populate-webroot', 10:56:32 INFO - 'create-virtualenv', 10:56:32 INFO - 'install', 10:56:32 INFO - 'run-tests'), 10:56:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:32 INFO - 'download_minidump_stackwalk': True, 10:56:32 INFO - 'download_symbols': 'ondemand', 10:56:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:32 INFO - 'installer_path': 'installer.exe', 10:56:32 INFO - 'log_level': 'info', 10:56:32 INFO - 'log_name': 'talos', 10:56:32 INFO - 'log_to_console': True, 10:56:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:32 INFO - 'opt_config_files': (), 10:56:32 INFO - 'pip_index': False, 10:56:32 INFO - 'sps_profile': False, 10:56:32 INFO - 'sps_profile_interval': 0, 10:56:32 INFO - 'suite': 'dromaeojs-e10s', 10:56:32 INFO - 'system_bits': '32', 10:56:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:32 INFO - 'title': 'talos-linux64-ix-059', 10:56:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:32 INFO - 'use_talos_json': True, 10:56:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:56:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:32 INFO - 'work_dir': 'build'} 10:56:32 INFO - ##### 10:56:32 INFO - ##### Running clobber step. 10:56:32 INFO - ##### 10:56:32 INFO - Running pre-action listener: _resource_record_pre_action 10:56:32 INFO - Running main action method: clobber 10:56:32 INFO - rmtree: /builds/slave/test-pgo/build 10:56:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:56:33 INFO - Running post-action listener: _resource_record_post_action 10:56:33 INFO - ##### 10:56:33 INFO - ##### Running read-buildbot-config step. 10:56:33 INFO - ##### 10:56:33 INFO - Running pre-action listener: _resource_record_pre_action 10:56:33 INFO - Running main action method: read_buildbot_config 10:56:33 INFO - Using buildbot properties: 10:56:33 INFO - { 10:56:33 INFO - "project": "", 10:56:33 INFO - "product": "firefox", 10:56:33 INFO - "script_repo_revision": "production", 10:56:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:56:33 INFO - "repository": "", 10:56:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:56:33 INFO - "buildid": "20160106083214", 10:56:33 INFO - "pgo_build": "True", 10:56:33 INFO - "basedir": "/builds/slave/test-pgo", 10:56:33 INFO - "buildnumber": 184, 10:56:33 INFO - "slavename": "talos-linux64-ix-059", 10:56:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:56:33 INFO - "platform": "ubuntu64_hw", 10:56:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:56:33 INFO - "branch": "fx-team", 10:56:33 INFO - "repo_path": "integration/fx-team", 10:56:33 INFO - "revision": "c1959d17af7cb8048f48c71727fcea8b9fcf17ae", 10:56:33 INFO - "stage_platform": "linux64-pgo", 10:56:33 INFO - "builduid": "b049be186d3346f68008e9346eb4c3d5", 10:56:33 INFO - "slavebuilddir": "test" 10:56:33 INFO - } 10:56:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:56:33 INFO - Running post-action listener: _resource_record_post_action 10:56:33 INFO - ##### 10:56:33 INFO - ##### Running download-and-extract step. 10:56:33 INFO - ##### 10:56:33 INFO - Running pre-action listener: _resource_record_pre_action 10:56:33 INFO - Running main action method: download_and_extract 10:56:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:33 INFO - https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/test_packages.json 10:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/test_packages.json 10:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:56:33 INFO - Downloaded 1302 bytes. 10:56:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:56:33 INFO - Using the following test package requirements: 10:56:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'jsshell-linux-x86_64.zip'], 10:56:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:33 INFO - https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:35 INFO - Downloaded 24101983 bytes. 10:56:35 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 10:56:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:35 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 10:56:36 INFO - Return code: 0 10:56:36 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 10:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:36 INFO - https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:38 INFO - Downloaded 24101983 bytes. 10:56:38 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 10:56:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:38 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 10:56:40 INFO - Return code: 0 10:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:40 INFO - https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:41 INFO - Downloaded 11132285 bytes. 10:56:41 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 10:56:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:41 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 10:56:42 INFO - Return code: 0 10:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:42 INFO - https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aYseBTuZSWiPADMYuodw2A/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 10:56:45 INFO - Downloaded 55054966 bytes. 10:56:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:45 INFO - mkdir: /builds/slave/test-pgo/properties 10:56:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:56:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:56:45 INFO - Contents: 10:56:45 INFO - build_url:https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:56:45 INFO - Running post-action listener: _resource_record_post_action 10:56:45 INFO - Running post-action listener: set_extra_try_arguments 10:56:45 INFO - ##### 10:56:45 INFO - ##### Running populate-webroot step. 10:56:45 INFO - ##### 10:56:45 INFO - Running pre-action listener: _resource_record_pre_action 10:56:45 INFO - Running main action method: populate_webroot 10:56:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:45 INFO - '--tppagecycles', 10:56:45 INFO - '7'], 10:56:45 INFO - 'tests': ['tsvgm']}}, 10:56:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:56:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'tests': ['damp', 'tps']}, 10:56:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['damp', 'tps']}, 10:56:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:45 INFO - 'other': {'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'other_l64': {'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:45 INFO - 'ts_paint', 10:56:45 INFO - 'tpaint', 10:56:45 INFO - 'sessionrestore', 10:56:45 INFO - 'sessionrestore_no_auto_restore']}, 10:56:45 INFO - 'svgr': {'tests': ['tsvgx', 10:56:45 INFO - 'tsvgr_opacity', 10:56:45 INFO - 'tart', 10:56:45 INFO - 'tscrollx', 10:56:45 INFO - 'cart']}, 10:56:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['tsvgx', 10:56:45 INFO - 'tsvgr_opacity', 10:56:45 INFO - 'tart', 10:56:45 INFO - 'tscrollx', 10:56:45 INFO - 'cart']}, 10:56:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'tests': ['tp5o']}, 10:56:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'talos_options': ['--e10s'], 10:56:45 INFO - 'tests': ['tp5o']}, 10:56:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'talos_options': ['--xperf_path', 10:56:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:45 INFO - 'tests': ['tp5n']}, 10:56:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:45 INFO - 'talos_options': ['--e10s', 10:56:45 INFO - '--xperf_path', 10:56:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:45 INFO - 'tests': ['tp5n']}}, 10:56:45 INFO - 'talos.zip': {'path': '', 10:56:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:45 INFO - Running post-action listener: _resource_record_post_action 10:56:45 INFO - ##### 10:56:45 INFO - ##### Running create-virtualenv step. 10:56:45 INFO - ##### 10:56:45 INFO - Running pre-action listener: _resource_record_pre_action 10:56:45 INFO - Running main action method: create_virtualenv 10:56:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:56:45 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 10:56:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:56:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:46 INFO - Using real prefix '/usr' 10:56:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:56:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:48 INFO - Installing pip.................done. 10:56:48 INFO - Return code: 0 10:56:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:56:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:56:48 INFO - Using env: {'DISPLAY': ':0', 10:56:48 INFO - 'HOME': '/home/cltbld', 10:56:48 INFO - 'LANG': 'en_US.UTF-8', 10:56:48 INFO - 'LANGUAGE': 'en_US:en', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MAIL': '/var/mail/cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SHLVL': '1', 10:56:48 INFO - 'TERM': 'linux', 10:56:48 INFO - 'TMOUT': '86400', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - '_': '/tools/buildbot/bin/python'} 10:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:48 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 10:56:48 INFO - Cleaning up... 10:56:48 INFO - Return code: 0 10:56:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:56:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:56:48 INFO - Using env: {'DISPLAY': ':0', 10:56:48 INFO - 'HOME': '/home/cltbld', 10:56:48 INFO - 'LANG': 'en_US.UTF-8', 10:56:48 INFO - 'LANGUAGE': 'en_US:en', 10:56:48 INFO - 'LOGNAME': 'cltbld', 10:56:48 INFO - 'MAIL': '/var/mail/cltbld', 10:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:48 INFO - 'MOZ_NO_REMOTE': '1', 10:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:48 INFO - 'NO_EM_RESTART': '1', 10:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:48 INFO - 'SHELL': '/bin/bash', 10:56:48 INFO - 'SHLVL': '1', 10:56:48 INFO - 'TERM': 'linux', 10:56:48 INFO - 'TMOUT': '86400', 10:56:48 INFO - 'USER': 'cltbld', 10:56:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:48 INFO - '_': '/tools/buildbot/bin/python'} 10:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:48 INFO - Downloading/unpacking psutil>=0.7.1 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:56:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:56:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:50 INFO - Installing collected packages: psutil 10:56:50 INFO - Running setup.py install for psutil 10:56:50 INFO - building 'psutil._psutil_linux' extension 10:56:50 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 10:56:50 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 10:56:50 INFO - building 'psutil._psutil_posix' extension 10:56:50 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 10:56:51 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 10:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:51 INFO - Successfully installed psutil 10:56:51 INFO - Cleaning up... 10:56:51 INFO - Return code: 0 10:56:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:51 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 10:56:51 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 10:56:51 INFO - Using env: {'DISPLAY': ':0', 10:56:51 INFO - 'HOME': '/home/cltbld', 10:56:51 INFO - 'LANG': 'en_US.UTF-8', 10:56:51 INFO - 'LANGUAGE': 'en_US:en', 10:56:51 INFO - 'LOGNAME': 'cltbld', 10:56:51 INFO - 'MAIL': '/var/mail/cltbld', 10:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:51 INFO - 'MOZ_NO_REMOTE': '1', 10:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:51 INFO - 'NO_EM_RESTART': '1', 10:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:51 INFO - 'SHELL': '/bin/bash', 10:56:51 INFO - 'SHLVL': '1', 10:56:51 INFO - 'TERM': 'linux', 10:56:51 INFO - 'TMOUT': '86400', 10:56:51 INFO - 'USER': 'cltbld', 10:56:51 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:51 INFO - '_': '/tools/buildbot/bin/python'} 10:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:51 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 10:56:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:56:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:56:53 INFO - Installing collected packages: mozsystemmonitor 10:56:53 INFO - Running setup.py install for mozsystemmonitor 10:56:53 INFO - Successfully installed mozsystemmonitor 10:56:53 INFO - Cleaning up... 10:56:53 INFO - Return code: 0 10:56:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:56:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:56:53 INFO - Using env: {'DISPLAY': ':0', 10:56:53 INFO - 'HOME': '/home/cltbld', 10:56:53 INFO - 'LANG': 'en_US.UTF-8', 10:56:53 INFO - 'LANGUAGE': 'en_US:en', 10:56:53 INFO - 'LOGNAME': 'cltbld', 10:56:53 INFO - 'MAIL': '/var/mail/cltbld', 10:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:53 INFO - 'MOZ_NO_REMOTE': '1', 10:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:53 INFO - 'NO_EM_RESTART': '1', 10:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:53 INFO - 'SHELL': '/bin/bash', 10:56:53 INFO - 'SHLVL': '1', 10:56:53 INFO - 'TERM': 'linux', 10:56:53 INFO - 'TMOUT': '86400', 10:56:53 INFO - 'USER': 'cltbld', 10:56:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:53 INFO - '_': '/tools/buildbot/bin/python'} 10:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:53 INFO - Downloading/unpacking blobuploader==1.2.4 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:53 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 10:56:55 INFO - Downloading blobuploader-1.2.4.tar.gz 10:56:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:56:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:56:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:56:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:56:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:55 INFO - Downloading docopt-0.6.1.tar.gz 10:56:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:56:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:56 INFO - Running setup.py install for blobuploader 10:56:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:56:56 INFO - Running setup.py install for requests 10:56:56 INFO - Running setup.py install for docopt 10:56:56 INFO - Successfully installed blobuploader requests docopt 10:56:56 INFO - Cleaning up... 10:56:56 INFO - Return code: 0 10:56:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:56 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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:56 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 10:56:56 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 10:56:56 INFO - Using env: {'DISPLAY': ':0', 10:56:56 INFO - 'HOME': '/home/cltbld', 10:56:56 INFO - 'LANG': 'en_US.UTF-8', 10:56:56 INFO - 'LANGUAGE': 'en_US:en', 10:56:56 INFO - 'LOGNAME': 'cltbld', 10:56:56 INFO - 'MAIL': '/var/mail/cltbld', 10:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:56 INFO - 'MOZ_NO_REMOTE': '1', 10:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:56 INFO - 'NO_EM_RESTART': '1', 10:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:56 INFO - 'SHELL': '/bin/bash', 10:56:56 INFO - 'SHLVL': '1', 10:56:56 INFO - 'TERM': 'linux', 10:56:56 INFO - 'TMOUT': '86400', 10:56:56 INFO - 'USER': 'cltbld', 10:56:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:56 INFO - '_': '/tools/buildbot/bin/python'} 10:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:56 INFO - Running setup.py (path:/tmp/pip-uSL1OA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:56 INFO - Running setup.py (path:/tmp/pip-Ku8UNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:56:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:56 INFO - Running setup.py (path:/tmp/pip-I2LT45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:57 INFO - Running setup.py (path:/tmp/pip-yAli4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:57 INFO - Running setup.py (path:/tmp/pip-IefB1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:57 INFO - Running setup.py (path:/tmp/pip-fOD13D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:57 INFO - Running setup.py (path:/tmp/pip-YgD3oG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:57 INFO - Running setup.py (path:/tmp/pip-6IXMCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:57 INFO - Running setup.py (path:/tmp/pip-GhT0eC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:57 INFO - Running setup.py (path:/tmp/pip-ptx5Nu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:57 INFO - Running setup.py (path:/tmp/pip-dYp55K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:57 INFO - Running setup.py (path:/tmp/pip-n0Vwvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:57 INFO - Running setup.py (path:/tmp/pip-defVqU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:57 INFO - Running setup.py (path:/tmp/pip-ZHBSjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:57 INFO - Running setup.py (path:/tmp/pip-rNw31R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:57 INFO - Running setup.py (path:/tmp/pip-E85Pak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:56:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:57 INFO - Running setup.py (path:/tmp/pip-4dGYX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:56:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:58 INFO - Running setup.py install for manifestparser 10:56:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Running setup.py install for mozcrash 10:56:58 INFO - Running setup.py install for mozdebug 10:56:58 INFO - Running setup.py install for mozdevice 10:56:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Running setup.py install for mozfile 10:56:58 INFO - Running setup.py install for mozhttpd 10:56:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Running setup.py install for mozinfo 10:56:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Running setup.py install for mozInstall 10:56:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:56:58 INFO - Running setup.py install for mozleak 10:56:58 INFO - Running setup.py install for mozlog 10:56:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Running setup.py install for moznetwork 10:56:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Running setup.py install for mozprocess 10:56:59 INFO - Running setup.py install for mozprofile 10:56:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Running setup.py install for mozrunner 10:56:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Running setup.py install for mozscreenshot 10:56:59 INFO - Running setup.py install for moztest 10:56:59 INFO - Running setup.py install for mozversion 10:56:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:56:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:59 INFO - Cleaning up... 10:56:59 INFO - Return code: 0 10:56:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:56: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')]} 10:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', '-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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:56:59 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 10:56:59 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 10:56:59 INFO - Using env: {'DISPLAY': ':0', 10:56:59 INFO - 'HOME': '/home/cltbld', 10:56:59 INFO - 'LANG': 'en_US.UTF-8', 10:56:59 INFO - 'LANGUAGE': 'en_US:en', 10:56:59 INFO - 'LOGNAME': 'cltbld', 10:56:59 INFO - 'MAIL': '/var/mail/cltbld', 10:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:59 INFO - 'MOZ_NO_REMOTE': '1', 10:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:56:59 INFO - 'NO_EM_RESTART': '1', 10:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:56:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:56:59 INFO - 'SHELL': '/bin/bash', 10:56:59 INFO - 'SHLVL': '1', 10:56:59 INFO - 'TERM': 'linux', 10:56:59 INFO - 'TMOUT': '86400', 10:56:59 INFO - 'USER': 'cltbld', 10:56:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:59 INFO - '_': '/tools/buildbot/bin/python'} 10:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:00 INFO - Running setup.py (path:/tmp/pip-68O6dP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:00 INFO - Running setup.py (path:/tmp/pip-PyZSPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:00 INFO - Running setup.py (path:/tmp/pip-Z9Z3BZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:00 INFO - Running setup.py (path:/tmp/pip-LesBnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:00 INFO - Running setup.py (path:/tmp/pip-Vk75fp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:00 INFO - Running setup.py (path:/tmp/pip-FR443i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:00 INFO - Running setup.py (path:/tmp/pip-XWkjqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:00 INFO - Running setup.py (path:/tmp/pip-e3tTlb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:00 INFO - Running setup.py (path:/tmp/pip-Qtf3tv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:00 INFO - Running setup.py (path:/tmp/pip-DeLkPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:00 INFO - Running setup.py (path:/tmp/pip-aqdgyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:00 INFO - Running setup.py (path:/tmp/pip-e8DyMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:00 INFO - Running setup.py (path:/tmp/pip-d9Cka1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:00 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)) 10:57:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:00 INFO - Running setup.py (path:/tmp/pip-uEAXUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:01 INFO - Running setup.py (path:/tmp/pip-hzEmzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:01 INFO - Running setup.py (path:/tmp/pip-WbAdsh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:01 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)) 10:57:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:01 INFO - Running setup.py (path:/tmp/pip-R4M5sb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:01 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)) 10:57:01 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)) 10:57:01 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)) 10:57:01 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)) 10:57:01 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)) 10:57:01 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)) 10:57:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:02 INFO - Downloading blessings-1.5.1.tar.gz 10:57:02 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 10:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:03 INFO - Installing collected packages: blessings 10:57:03 INFO - Running setup.py install for blessings 10:57:03 INFO - Successfully installed blessings 10:57:03 INFO - Cleaning up... 10:57:03 INFO - Return code: 0 10:57:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:03 INFO - Reading from file tmpfile_stdout 10:57:03 INFO - Current package versions: 10:57:03 INFO - argparse == 1.2.1 10:57:03 INFO - blessings == 1.5.1 10:57:03 INFO - blobuploader == 1.2.4 10:57:03 INFO - docopt == 0.6.1 10:57:03 INFO - manifestparser == 1.1 10:57:03 INFO - mozInstall == 1.12 10:57:03 INFO - mozcrash == 0.16 10:57:03 INFO - mozdebug == 0.1 10:57:03 INFO - mozdevice == 0.47 10:57:03 INFO - mozfile == 1.2 10:57:03 INFO - mozhttpd == 0.7 10:57:03 INFO - mozinfo == 0.9 10:57:03 INFO - mozleak == 0.1 10:57:03 INFO - mozlog == 3.1 10:57:03 INFO - moznetwork == 0.27 10:57:03 INFO - mozprocess == 0.22 10:57:03 INFO - mozprofile == 0.28 10:57:03 INFO - mozrunner == 6.11 10:57:03 INFO - mozscreenshot == 0.1 10:57:03 INFO - mozsystemmonitor == 0.0 10:57:03 INFO - moztest == 0.7 10:57:03 INFO - mozversion == 1.4 10:57:03 INFO - psutil == 3.1.1 10:57:03 INFO - requests == 1.2.3 10:57:03 INFO - wsgiref == 0.1.2 10:57:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:57:03 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 10:57:03 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 10:57:03 INFO - Using env: {'DISPLAY': ':0', 10:57:03 INFO - 'HOME': '/home/cltbld', 10:57:03 INFO - 'LANG': 'en_US.UTF-8', 10:57:03 INFO - 'LANGUAGE': 'en_US:en', 10:57:03 INFO - 'LOGNAME': 'cltbld', 10:57:03 INFO - 'MAIL': '/var/mail/cltbld', 10:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:03 INFO - 'MOZ_NO_REMOTE': '1', 10:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:03 INFO - 'NO_EM_RESTART': '1', 10:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:03 INFO - 'SHELL': '/bin/bash', 10:57:03 INFO - 'SHLVL': '1', 10:57:03 INFO - 'TERM': 'linux', 10:57:03 INFO - 'TMOUT': '86400', 10:57:03 INFO - 'USER': 'cltbld', 10:57:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:03 INFO - '_': '/tools/buildbot/bin/python'} 10:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 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)) 10:57:03 INFO - Cleaning up... 10:57:03 INFO - Return code: 0 10:57:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:57:03 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 10:57:03 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 10:57:03 INFO - Using env: {'DISPLAY': ':0', 10:57:03 INFO - 'HOME': '/home/cltbld', 10:57:03 INFO - 'LANG': 'en_US.UTF-8', 10:57:03 INFO - 'LANGUAGE': 'en_US:en', 10:57:03 INFO - 'LOGNAME': 'cltbld', 10:57:03 INFO - 'MAIL': '/var/mail/cltbld', 10:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:03 INFO - 'MOZ_NO_REMOTE': '1', 10:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:03 INFO - 'NO_EM_RESTART': '1', 10:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:03 INFO - 'SHELL': '/bin/bash', 10:57:03 INFO - 'SHLVL': '1', 10:57:03 INFO - 'TERM': 'linux', 10:57:03 INFO - 'TMOUT': '86400', 10:57:03 INFO - 'USER': 'cltbld', 10:57:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:03 INFO - '_': '/tools/buildbot/bin/python'} 10:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:03 INFO - Downloading/unpacking jsonschema 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:05 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 10:57:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 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 10:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:05 INFO - warning: no files found matching '*.txt' 10:57:05 INFO - no previously-included directories found matching 'build' 10:57:05 INFO - no previously-included directories found matching 'dist' 10:57:05 INFO - no previously-included directories found matching '.git*' 10:57:05 INFO - Installing collected packages: jsonschema, functools32 10:57:05 INFO - Running setup.py install for functools32 10:57:05 INFO - warning: no files found matching '*.txt' 10:57:05 INFO - no previously-included directories found matching 'build' 10:57:05 INFO - no previously-included directories found matching 'dist' 10:57:05 INFO - no previously-included directories found matching '.git*' 10:57:05 INFO - Successfully installed jsonschema functools32 10:57:05 INFO - Cleaning up... 10:57:06 INFO - Return code: 0 10:57:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f5937f39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d3b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', '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 10:57:06 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 10:57:06 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 10:57:06 INFO - Using env: {'DISPLAY': ':0', 10:57:06 INFO - 'HOME': '/home/cltbld', 10:57:06 INFO - 'LANG': 'en_US.UTF-8', 10:57:06 INFO - 'LANGUAGE': 'en_US:en', 10:57:06 INFO - 'LOGNAME': 'cltbld', 10:57:06 INFO - 'MAIL': '/var/mail/cltbld', 10:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:06 INFO - 'MOZ_NO_REMOTE': '1', 10:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:06 INFO - 'NO_EM_RESTART': '1', 10:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:06 INFO - 'SHELL': '/bin/bash', 10:57:06 INFO - 'SHLVL': '1', 10:57:06 INFO - 'TERM': 'linux', 10:57:06 INFO - 'TMOUT': '86400', 10:57:06 INFO - 'USER': 'cltbld', 10:57:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:06 INFO - '_': '/tools/buildbot/bin/python'} 10:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:06 INFO - Downloading/unpacking flake8 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:07 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 10:57:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:08 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 10:57:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:08 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 10:57:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:57:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:08 INFO - no previously-included directories found matching 'docs/_build' 10:57:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:08 INFO - Running setup.py install for pep8 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:08 INFO - no previously-included directories found matching 'docs/_build' 10:57:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:57:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:08 INFO - Cleaning up... 10:57:08 INFO - Return code: 0 10:57:08 INFO - Running post-action listener: _resource_record_post_action 10:57:08 INFO - Running post-action listener: _start_resource_monitoring 10:57:08 INFO - Starting resource monitoring. 10:57:08 INFO - ##### 10:57:08 INFO - ##### Running install step. 10:57:08 INFO - ##### 10:57:08 INFO - Running pre-action listener: _resource_record_pre_action 10:57:08 INFO - Running main action method: install 10:57:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:57:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:57:09 INFO - Reading from file tmpfile_stdout 10:57:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:57:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:57:09 INFO - Reading from file tmpfile_stdout 10:57:09 INFO - Output received: 10:57:09 INFO - Usage: mozinstall [options] installer 10:57:09 INFO - Options: 10:57:09 INFO - -h, --help show this help message and exit 10:57:09 INFO - -d DEST, --destination=DEST 10:57:09 INFO - Directory to install application into. [default: 10:57:09 INFO - "/builds/slave/test-pgo"] 10:57:09 INFO - --app=APP Application being installed. [default: firefox] 10:57:09 INFO - mkdir: /builds/slave/test-pgo/build/application 10:57:09 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'] 10:57:09 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 10:57:25 INFO - Reading from file tmpfile_stdout 10:57:25 INFO - Output received: 10:57:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:57:25 INFO - Running post-action listener: _resource_record_post_action 10:57:25 INFO - ##### 10:57:25 INFO - ##### Running run-tests step. 10:57:25 INFO - ##### 10:57:25 INFO - Running pre-action listener: _resource_record_pre_action 10:57:25 INFO - Running main action method: run_tests 10:57:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:57:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:57:25 INFO - Python 2.7.3 10:57:25 INFO - Return code: 0 10:57:25 INFO - grabbing minidump binary from tooltool 10:57:25 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')]} 10:57:25 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 0x1dca540>, '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 0x1dcb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dcb8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:57:25 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 10:57:25 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 10:57:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:25 INFO - Return code: 0 10:57:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:57:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:57:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:57:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:57:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:57:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:57:26 INFO - Return code: 0 10:57:26 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/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:57:26 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/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 10:57:26 INFO - Using env: {'DISPLAY': ':0', 10:57:26 INFO - 'HOME': '/home/cltbld', 10:57:26 INFO - 'LANG': 'en_US.UTF-8', 10:57:26 INFO - 'LANGUAGE': 'en_US:en', 10:57:26 INFO - 'LOGNAME': 'cltbld', 10:57:26 INFO - 'MAIL': '/var/mail/cltbld', 10:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:26 INFO - 'MOZ_NO_REMOTE': '1', 10:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:26 INFO - 'NO_EM_RESTART': '1', 10:57:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:26 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:57:26 INFO - 'SHELL': '/bin/bash', 10:57:26 INFO - 'SHLVL': '1', 10:57:26 INFO - 'TERM': 'linux', 10:57:26 INFO - 'TMOUT': '86400', 10:57:26 INFO - 'USER': 'cltbld', 10:57:26 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790', 10:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:26 INFO - '_': '/tools/buildbot/bin/python'} 10:57:26 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/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 10:57:26 INFO - mozversion application_buildid: 20160106083214 10:57:26 INFO - mozversion application_changeset: c1959d17af7cb8048f48c71727fcea8b9fcf17ae 10:57:26 INFO - mozversion application_display_name: Nightly 10:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:26 INFO - mozversion application_name: Firefox 10:57:26 INFO - mozversion application_remotingname: firefox 10:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:57:26 INFO - mozversion application_vendor: Mozilla 10:57:26 INFO - mozversion application_version: 46.0a1 10:57:26 INFO - mozversion platform_buildid: 20160106083214 10:57:26 INFO - mozversion platform_changeset: c1959d17af7cb8048f48c71727fcea8b9fcf17ae 10:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:26 INFO - mozversion platform_version: 46.0a1 10:57:26 INFO - using testdate: 1452106646 10:57:26 INFO - actual date: 1452106646 10:57:26 INFO - starting webserver on 'localhost:51498' 10:57:26 INFO - SUITE-START | Running 3 tests 10:57:26 INFO - TEST-START | dromaeo_css 10:57:26 INFO - operating with platform_type : linux_ 10:57:26 INFO - Initialising browser for dromaeo_css test... 10:57:26 INFO - TEST-INFO | started process 22793 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXBHccs/profile http://localhost:51498/getInfo.html) 10:57:29 INFO - PROCESS | 22793 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 10:57:30 INFO - PROCESS | 22793 | __metrics Screen width/height:1600/1200 10:57:30 INFO - PROCESS | 22793 | colorDepth:24 10:57:30 INFO - PROCESS | 22793 | Browser inner width/height: 1024/697 10:57:30 INFO - PROCESS | 22793 | __metrics 10:57:30 INFO - PROCESS | 22793 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:57:31 INFO - TEST-INFO | 22793: exit 0 10:57:31 INFO - Browser initialized. 10:57:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:31 INFO - TEST-INFO | started process 22926 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXBHccs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:43 INFO - PROCESS | 22926 | RSS: Main: 150511616 10:57:43 INFO - PROCESS | 22926 | 10:58:32 INFO - PROCESS | 22926 | 1452106712822 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] 11:00:41 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51498/tests/dromaeo/cssquery-ext.html) 11:00:43 INFO - PROCESS | 22926 | RSS: Main: 157618176 11:00:43 INFO - PROCESS | 22926 | 11:03:45 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-ext.html (next: http://localhost:51498/tests/dromaeo/cssquery-jquery.html) 11:03:45 INFO - PROCESS | 22926 | RSS: Main: 155357184 11:03:45 INFO - PROCESS | 22926 | 11:06:47 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51498/tests/dromaeo/cssquery-mootools.html) 11:06:48 INFO - PROCESS | 22926 | RSS: Main: 153903104 11:06:48 INFO - PROCESS | 22926 | 11:09:49 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51498/tests/dromaeo/cssquery-prototype.html) 11:09:50 INFO - PROCESS | 22926 | RSS: Main: 152412160 11:09:50 INFO - PROCESS | 22926 | 11:12:52 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51498/tests/dromaeo/cssquery-yui.html) 11:12:53 INFO - PROCESS | 22926 | RSS: Main: 153346048 11:12:53 INFO - PROCESS | 22926 | 11:15:55 INFO - PROCESS | 22926 | Cycle 1(1): loaded http://localhost:51498/tests/dromaeo/cssquery-yui.html (next: http://localhost:51498/tests/dromaeo/cssquery-dojo.html) 11:15:56 INFO - PROCESS | 22926 | RSS: Main: 155217920 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | __start_tp_report 11:15:56 INFO - PROCESS | 22926 | _x_x_mozilla_page_load 11:15:56 INFO - PROCESS | 22926 | _x_x_mozilla_page_load_details 11:15:56 INFO - PROCESS | 22926 | |i|pagename|runs| 11:15:56 INFO - PROCESS | 22926 | |0;dojo.html;3115.6105486814154;3156.479180935146;3185.697358750918;3188.585483887094;3201.0396880935714;5155.587552995761;5328.733563321833;5353.91969120463;5355.866103347418;5358.571314294857;5245.973770131153;5254.7635356408955;5276.894462110765;5314.468553144684;5334.706591137486;4814.951850481494;4874.049560335736;4908.067467181224;4941.061198372316;4996.5503104720565;4872.8050877965015;4913.778879950393;4923.876903077416;4996.600271978251;5006.173981293082;4743.0988112258565;4812.109759694467;4818.975905120487;4887.120318342697;4927.014597080581;4858.344123543312;4881.707097574122;4905.043516514281;4916.336294600219;4917.065757506098;4864.124457597631;4883.096627123993;4891.046245982035;4895.461499235082;4897.363342765453;5061.5950723942;5109.3613298337705;5121.052605268037;5151.17581187012;5225.268462415265;5781.277340332458;5790.449907258803;5793.246877905887;5801.564882633777;5803.9709801451145;5816;5830.62100963436;5837.270341207349;5839.708014599253;5843.2695913010875;5194.402643695986;5302.098643230622;5347.064263753867;5381.461853814626;5483.561315094863;5815.854603634943;5820.417958204146;5851.21008663825;5852.15143804146;5868.882622347529;5595.7481913313995;5614.9612321720615;5617.269754931833;5622.353429355595;5624.634398764068;5518.475744804237;5565.638233514808;5614.494695477427;5616.550675945915;5684.033714268584;5656.179853921159;5691.26013618227;5711.343195532484;5713.228714123623;5742.138679198154;5673.574481913873;5692.459216374438;5702.600817942787;5737.540996720252;5755.079187330007;4306.913861722748;4415.050764085737;4419.027813880941;4431.313146462304;4535.29702896045;3938.6455219030427;3952.466417033721;3959.148783011666;3981.960180398217;3983.64147226751;5418.078926582491;5418.756155972991;5442.564594832483;5444.727763611803;5448.155535891943;5604.635698679573;5625.718714064362;5689.516391106719;5693.544516438675;5694.345150307685;5267.868303292448;5299.973500132474;5307.363116425976;5310.7610157543;5314.4951229633125;4810.4467986181335;4819.879503012453;4820.734859582686;4899.58353539946;4983.127952608352;5791.855203619859;5801.854953626109;5835.474807267281;5878.647281163058;5981.312149102909;5648.124540696199;5708.771649133988;5711.257536520309;5719.742611582572;5737.655740655574;5760.452756988079;5785.132230165509;5991.310999234969;6024.728887199999;6045.939540604538;5618.157276408571;5680.233168522362;5684.63049901755;5686.800961966312;5704.401037891128;5588.524975376976;5721.542276617944;5730.255066841284;5733.885322293614;5735.684537350486;5441.21102440136;5455.754491047833;5459.863503412287;5468.753906074316;5480.780768769205;5448.727563621724;5470.370907345706;5506.063969125178;5576.163575463551;5639.097744360883;5501.119820828648;5519.586031047767;5522.447755224606;5529.612927095065;5535.197396377584;5499.945000549943;5574.080276754452;5639.774409023593;5667.093265077568;5707;5464.098423760194;5494.1758736189895;5548.889022219614;5574.554035677217;5612.691301978431 11:15:56 INFO - PROCESS | 22926 | |1;ext.html;528.6114705691317;530.5198795090442;533.8852146788437;551.4237621685339;555.4334578729694;34058.829705851465;34941.82529087351;35026.64973350266;35064.82467587662;35072.82463587685;37687.62312376875;37872;38005;38006.23987520248;38042.61957380425;8373.371997100227;8512.935883014623;8537;8539.573021348939;8549.95725021374;8312.41813073082;8352.457090289143;8356.247937685606;8415.368847336444;8418.368622353317;8238.917610823875;8263.091059983397;8282.917170828276;8287.751367458986;8329.08380078191;8557.700480483185;8560.957195214016;8585.484870907703;8586.742397728047;8595.140485951417;8452;8456.450330728483;8559.27246184075;8560.229579337827;8561.48631082137;37900.43149352762;38420;38462.807685961394;38504.61495385038;38516.229675406335;2971.286891146131;2973.821570705743;3030.1364111228195;3248.30161515273;3558.5729712434672;27132.59301110485;27244;27336;27972.440551189065;28568.571471427946;3688.61269566697;3744.1949980754;3782;3806.90482737931;3811.9707678926534;254058;255457;255985;256941;258062;50572.24141637805;52016;57077;57211.713941430025;57604.42395576074;63005.68497157576;64174.67912660407;64188.35811641917;64253.67873160604;64654.353456465775;13037.869621303855;13056.477740890448;13222.074454788073;13234.272115033573;13295.135816171918;10677.78644427107;10696.41169735672;10719.624813131502;10719.946400267949;10725.517351719036;19105.14026868794;19343.51641208981;19363;19382.612347752965;19461.805381946284;7324.926750732531;7628.656710448043;7654.387648988068;7660.119086305146;7723.150453450228;935.2377812083131;942.9009953954874;954.8519979403204;1012.7215015870547;1051.4374809476892;27513.72486275152;27877.163685089075;27901.720982790317;28186.577201341996;28255.858720706266;978.471625322318;1022.5407894014907;1037;1072.372661992743;1131.6944425005202;13586.456541738418;13607.727845443036;13824.447022119002;13840.653983650287;13914.652133696536;364059;370954;371809;372476;372913;49267.26099108516;49348.75325623349;49365.75317123391;49755.75122124366;49818;1270.339423499775;1270.9364531773374;1286.6140157952577;1293.049608537724;1304.8238487804024;23062.884685576464;23219.535609288057;23302.883485582464;23457.53084938326;23480.178193763135;39304.606953930095;39433.80283098566;39626.60373396229;39694.80152599219;39998.2000359997;290571;292085.935273562;292458;292764;294725;29934.401311974074;41142.58857411388;42118.15763684648;42192.78903605462;42405.1518969625;39569;40600.390994135705;40691.18617627572;40840.59159408368;41348.1730365385;34139.31721365509;34298.31403371968;34379.82810085933;34568.48147277843;34920.30159396747;32834.835825820715;34427.483587746705;34829.65170348264;34902.476462853585;36581.817090914374;33092.85617866299;33733.49399759054;33901.66098338985;34306.828465857514;34329.31341373209;31055.534166987964;32078;32456.83771581127;32613.18467038343;35470;23913.880430597736;23940.40148996289;24357.878210608833;24394;24528 11:15:56 INFO - PROCESS | 22926 | |2;jquery.html;353.8142475200521;359.3764818040699;361.1278761790277;362.21038136861637;362.3170323939373;15541.456049038286;15892.920535397321;16730.66538669226;17478.563035924108;18232;10500.947495262513;11083.556657733681;14807.92596037021;14849.257537123154;14897.77653335201;4804.375431193948;4820.421549414075;4932.112219800434;4939;4944.480829512903;4856.878578035542;4874.707517548941;4888.633352498577;4897.608191344684;4900.558949694527;4858.635602329822;4964.826231081895;4971.304017437562;5249.685018898859;5438.83683489496;5329.520343169133;5348.572114230852;5352.705601191933;5353.170258609922;5376.11294136467;4815.975920120412;5116.539511443951;5152.845414637567;5294.973525132388;5320.228566857784;13332.533361332404;13357.33213339329;14336.49822256216;20311.28910488126;20572.5885482291;2050.1286953044896;2052.5279185787203;2068.534579719566;2079.6152711748373;2136.401807493904;9262.583183756748;9534.618615255451;9574.186194173504;9691.563879625433;12629.873701263054;1748.8950662960135;1796.3084212578121;1802.3331367394017;1816.7547381103514;1818.1454716283326;58478.41521584772;58733.11900321498;58753;62710.0593491098;62904.05643915391;10257.128144107834;10273.537690803782;10279.691609251735;10296.845547316796;10298.17614590831;13237.470501179845;13302.800457992944;13306.800397994039;13309.866901331057;13324.933375333256;7194.38847697941;7231.349178573953;7241.782746517613;7394.926050739531;7527.698892044366;7208.855822883513;7220.819479512949;7223.205447400782;7235.384992275715;7285.927140728525;4472.217361961643;4551.203539380661;4558.772061396917;4562.840300589463;4585.541445855454;1825.302468704118;1837.2191818477095;1838.5311745505078;1872.279172518563;1880;457.1223251357402;468.59421734795615;890.7238755985666;964.623796719266;979.9167070798919;10605.628802991858;11136.38749868765;11164.720881978015;11194.384308862927;11429.657110286538;445.39648775908825;476.9332293478916;484.62925861715814;486.99756501217973;489.13667377079486;5909.527237820964;6046.697665116727;6079.726412311456;6108.175396321529;6153.1693221415435;526183;526879;527361;543102;549831;41215;41440;78834;80357.39285214263;81112.59443702744;500.7646406189085;507.99492005080214;510.71144803186826;510.8544064941474;513.1558586125802;9832.801759147493;9997.150242229493;10033.548490318099;10064.163143496642;10317.793644127225;30984;30991;31444;32006.6799332013;32603.673963260062;38772.41841372438;40748.79625601853;41454.37818432786;43882.341764872916;44564.331535027646;9091.863622045543;9494.192993595345;9826.213902887896;10039.849402258826;10088.495575221357;11509.36698481558;11595.420228988685;11616.941915290707;11640.301581905112;15882.920585397;13552.457901683822;13630.182189068688;13817.723645527234;13857.237851917838;14546.4908728194;11828.467718952495;12903;13347.199168049949;14220.431182752574;14382.137071775727;12865.807012894627;15122.621934451287;15138.697226055638;15159.772603411178;15160.422728136464;9733.124018838338;9925.602975880884;9973.451460169761;9977.401355918668;10032.749181270527;14781.260936953324;14841.628959275673;14982.101073935599;15036.924815376291;15311.693766124838 11:15:56 INFO - PROCESS | 22926 | |3;mootools.html;1379.1173648864728;1400.1039334825712;1524.5121561100452;1716.4421562992031;1721.561001944504;6556.082148499214;6653.667316634161;7122.074130363058;7419.777406677795;7456.32893039627;7060.258672839342;7094.609796461193;7140.428765698744;7152.3920466760255;7154.177269613996;2167.6531754919215;2192.331338941622;2198.4723666320047;2198.923037693681;2200.2849074050996;2224.22152246714;2239.6304609739373;2303.34354708908;2308.8268379871492;2310.953780924389;2216.1689366487567;2219.511707424364;2240.843140980132;2247.2471721973156;2270.7842754938256;2255.6842042114117;2259.841811073209;2293.9311820645407;2321.58211521926;2327.592671282519;2244.9214277500373;2261.4459457432868;2267.7392099908557;2278.225403362848;2278.840481166319;7466.925330746677;7533.472656914018;7548.169701332849;7572.734954276629;7604;4434.756088415136;4485.686001979862;4495.865124046284;4510.932336014962;4541.909161816779;2904.390078083605;2990.6710261871176;2999.7150270724246;3001.429728351628;3002.369502404498;960.2030314838668;963.5904740485336;994.318891559277;998.8451789972565;1015.3603229965148;10354.741131471697;10362.533685984225;10366.06705396518;10368.377897326109;10386.79226415475;4041.535223449282;4104.774237416971;4115.97942010294;4135.214309281227;4161.126163505637;8827.514486703292;8844.734657960144;8885.333599980027;8885.600147993357;8897.28821694276;4578.107269082497;4593.701409408378;4629.629629629621;4645.442546894326;4658.673892827537;4063.2889244382113;4123.154753275571;4160.313548264502;4215.810288537024;4222.408862759216;3393.168673674916;3412.863485460554;3414.385410626111;3416.7779094359284;3435.845386957593;1054.1935419404163;1056.6882769582992;1066.0991462214417;1068.58859339155;1069.04320633033;954.1746389373142;954.2127744610724;958.7459323279337;1031.6492392586556;1274.350081458463;6958.582485050812;7039.824004399931;7067.858642827217;7073.363397294268;7078.575285482888;495.5911373117121;1063.6543123484898;1103.9448027598587;1158.6813626252679;1195.2290772451893;5475.808346707926;5512.5589952804485;5602.915956260659;5602.943970560324;5643.5767317451355;8993.055729148346;9123.908760912305;9129.45223286605;9186.127317904788;9224.53877306132;8796.032436431988;8867.778305542284;8886.066962968924;8997.730068097968;9040;7035.12060992376;7128.92871071293;7143.857122857514;7163.67763450646;7172.856542869114;6848.7260509579055;6861.656917154022;6954.095967524189;6959.338862808025;7001.579905205704;7951.165127661744;8043;8059.879101813361;8187.590620468834;8294.917050829414;8246.505209687439;8305.377096717892;8330.208630180123;8387.203215694499;8439.915600844159;5851.414858514115;5945.316288626863;6183.84540386494;6551.148350714377;6625.900611490735;6891.138607674041;6936.4797640176175;6948.513604047668;6970.372666460043;6979.511434199558;6421.839454013687;6680.799576012728;6696.631685257357;6774.898376524257;6809.8638027238185;6428.19647544057;6488.772892948913;6495.253045899782;6506.186726659168;6518.348165183444;6144.170536977451;6219.036049412348;6236.126942228001;6240.00159974402;6267.780627678009;5856.4143585641095;5862.12068189775;5897.292324921037;5930.970345148419;5935.970320148372;5900.616459930091;5949.702514874152;5950.137230101524;5956.523478121827;5982.611130276518 11:15:56 INFO - PROCESS | 22926 | |4;prototype.html;331.14068990968434;338.29296769751215;343.8315225539486;344.10361009570056;352.7883270037976;6132.110843927628;6152.477039451641;6158.384161583839;6167.722452489632;6245.781397651083;6127.142200091979;6152.230971128609;6175.289841668198;6186.628802271867;6210.627362358262;4723.338732577442;4725.787339569728;4726.291056341542;4735.029318989599;4742.027884283731;4718.598919091882;4721.315409265654;4723.929141062887;4726.7400292983875;4736;4491.371208030879;4532.116237333721;4626.21354369758;4649.558291962258;4674.415698037746;4629.3518907353;4632.606228470601;4656.278276867074;4669.766511674403;4680.297955306732;4022.3966405039187;4039.8586049488126;4051.027753339207;4065.7763822989723;4091.754494730326;5868.559858010666;5872.060470324727;5873.709253391138;5874.50066744323;5881.823545293648;5254.500822421864;5429.212764149216;5456.563474921997;5471.343438787371;5486;6536.052272420472;6536.41172294491;6536.836579085513;6546.116274302955;6556.737730490775;4506.752128632924;4515.367848501212;4520.367148599166;4526.547345265447;4539.954600453986;6686.765963191265;6746.797596072126;6765.120534330555;6785.898211526831;6803.523753337268;4630.3748993886065;4636.79134438951;4639.976800115978;4641.118187544424;4641.559051890065;4692.601128904013;4693.366395536627;4709.529047095331;4711.151992641289;4716.622670186377;5389.946100539023;5417.10617748075;5422.8373148805595;5432.782688692408;5445.945540544623;6414.8717025659225;6552.639604821685;6560.606363618198;6593.703283352261;6606.141201643852;1640.6144556029324;1646.4319809665647;1651.9917400413162;1659.9874076813135;1662.3599914033184;1089.6131873185063;1089.6676513663251;1101.2841652925663;1110.722319420145;1115.7210697325668;6238.220222472191;6302.338254483213;6308.873822523616;6315;6315.242170939517;6718.824205764069;6751.628660423626;6762.120924279812;6792.8301792454595;6818.522703410714;6008.399160083956;6196.752129914753;6247.625142491374;6276.152719382916;6279.058141278753;3659.8902032939054;3663.084228942764;3692.7968961707365;3705.444183372516;3711.2206436648607;7147.64261786919;7212.531185472927;7215.71137154508;7219;7239.420846332281;6898.172219333712;6913.0667359905765;6984.371406573331;6994.650267486605;7049.224585295613;7215.67529461165;7216.134063912364;7222.566646001257;7225.277472252733;7237.203907570163;6805.115335006418;6844.93155068443;6860.794176174722;6863.10779598649;6893.551919125442;6602.1747281589805;6798.014287928124;6800.081988931431;6811;6813.216480104653;7154.069970903957;7179.246179151114;7186.1376634804155;7204;7211.134663840373;4666.743329116931;4671.065786842577;4674.298855171752;4676.088162808356;4677.906441871075;6715.664216789043;6718.462522998051;6858.759943401957;6859.348361905611;6869.278725733726;6679.2318883329035;6681;6681.498887583548;6685.76599819004;6687.899681504879;6480.513961452815;6629.337066293332;6642.83392915181;6651.06885036105;6663.200415949923;6492.707828147839;6505.51208659343;6524.1518602583255;6534.901976470262;6544.6727663615675;6644.136262285871;6646.60120392778;6685.732570697312;6699.09562209115;6706.698198580978;6432.35676432353;6473.255575608865;6510.73957041732;6525.151730275224;6552.803415897531 11:15:56 INFO - PROCESS | 22926 | |5;yui.html;752.6387334079642;783.4006984656738;823.7207705967497;834.9980023971236;838.7651457591872;12770.872291277085;12772.552960646379;12854.16447930885;12974.091813573054;13010.739785204301;12302;12312.13815032948;12338.259704417718;12350.752984940296;12363.258204507736;753.8680730872089;766.9194734552875;786.4848524216648;800.1558355934516;802.2819576479047;772.8145245141154;780.063923292049;782.3819182845574;783.9216078392172;784.4391260248921;824.2334628795218;828.035338830262;833.5832083958021;834.7287131682198;835.4444294544121;822.8066404394963;823.7322870067252;824.8968878890139;824.9770284846746;825.7110011495988;604.3261763134118;605.6366180291834;608.4523928464417;608.5800797449746;610.2006371653149;12459.12786104973;12478.937605312007;12548.435320410603;12583.119181657288;12613.936930315382;11136.220464567483;11195.944020279929;11262.21164518484;11349.43252837363;11605.825912611317;10043.246756493292;10095.596176152945;10100.191984641284;10120.746981325452;10204.438755868425;3548.9112772180642;3562.8218589070443;3568.839402226906;3607.549056367954;3686.3548878946344;48207.75896120497;48828.267575986385;48850.26724599134;48997.75501122472;49294;8856.822863542693;8923.286137109015;9193.816123677489;9464.337496375188;9683.757906052406;17432;17434.47696569105;17447.73828392575;17471.56321091983;17471.65056698859;6738.966305168443;6765.695543700545;6813.148356455443;6918;7008.614526201108;4034.65705415043;4064.3293856513937;4110.527289361702;4181.330987042059;4282.528921818597;2963.9703602963696;2980.478416277143;2988.581598576201;2989.0584465893176;3006.6392032956187;500.56951022120944;504.8788290810179;514.182449904646;516.2901011109724;529.7721979548754;557.3896583241344;557.5483858074972;607.2470137030051;614.8063360041573;667.9732810687615;8409.663613455516;8417;8445.57772111392;8563.785905352415;8749.1250874912;504.85863958091795;579.6000759475949;583.7578544668813;668.9062639355565;678.1353773938268;3755.1363186467265;4019.979900100481;4076.7961601919787;4187.20443115807;4199.265128602482;52751.208731869054;52892;53055;53262.73368633132;53497.1975420369;47412.288815667795;47711.52288477071;47720.28419573709;47805;49318.26022609664;41723.37414938778;42088.158236835094;43134.56865431306;44675.32987005197;44818;8210.58947052633;8387.66449342044;8561.48631082137;8616.138386161334;8763.079876612865;31070.378592427573;31878;31973.20066998344;34350.31299374049;34509.30981380409;42298.15403691847;42476.78761606296;42580.574194257664;42936.57063429326;43038.78480607577;10239.027292407209;10452.581896724047;10734.302270352402;10937.671869843918;11032.558697652004;11305.321680699184;11546.942265288955;11567.595134170264;11701.122415818678;11853.34806585646;9455.243580513405;9875.407475551203;9884.703458896245;9955.950220248853;9964.800703986024;10789.838152427563;10812.243142979916;10849.511771970123;10903.727406814576;11217.326960382403;10211.489425528842;10419.791604168026;10568.365898046142;10798.406087665255;10803.513841876977;8739.91260087391;8791.780205494913;8891.244244239311;9204.585793639437;9317.767055823659;8478.194571515696;9388.765280868032;9466.062809129231;9558;9642.057832497137 11:15:56 INFO - PROCESS | 22926 | __end_tp_report 11:15:56 INFO - PROCESS | 22926 | __start_cc_report 11:15:56 INFO - PROCESS | 22926 | _x_x_mozilla_cycle_collect,311 11:15:56 INFO - PROCESS | 22926 | __end_cc_report 11:15:56 INFO - PROCESS | 22926 | __startTimestamp1452107756176__endTimestamp 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | ------- Summary: start ------- 11:15:56 INFO - PROCESS | 22926 | Number of tests: 6 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#0] dojo.html Cycles:165 Average:5302.58 Median:5483.56 stddev:583.66 (10.6%) stddev-sans-first:559.67 11:15:56 INFO - PROCESS | 22926 | Values: 3115.6 3156.5 3185.7 3188.6 3201.0 5155.6 5328.7 5353.9 5355.9 5358.6 5246.0 5254.8 5276.9 5314.5 5334.7 4815.0 4874.0 4908.1 4941.1 4996.6 4872.8 4913.8 4923.9 4996.6 5006.2 4743.1 4812.1 4819.0 4887.1 4927.0 4858.3 4881.7 4905.0 4916.3 4917.1 4864.1 4883.1 4891.0 4895.5 4897.4 5061.6 5109.4 5121.1 5151.2 5225.3 5781.3 5790.4 5793.2 5801.6 5804.0 5816.0 5830.6 5837.3 5839.7 5843.3 5194.4 5302.1 5347.1 5381.5 5483.6 5815.9 5820.4 5851.2 5852.2 5868.9 5595.7 5615.0 5617.3 5622.4 5624.6 5518.5 5565.6 5614.5 5616.6 5684.0 5656.2 5691.3 5711.3 5713.2 5742.1 5673.6 5692.5 5702.6 5737.5 5755.1 4306.9 4415.1 4419.0 4431.3 4535.3 3938.6 3952.5 3959.1 3982.0 3983.6 5418.1 5418.8 5442.6 5444.7 5448.2 5604.6 5625.7 5689.5 5693.5 5694.3 5267.9 5300.0 5307.4 5310.8 5314.5 4810.4 4819.9 4820.7 4899.6 4983.1 5791.9 5801.9 5835.5 5878.6 5981.3 5648.1 5708.8 5711.3 5719.7 5737.7 5760.5 5785.1 5991.3 6024.7 6045.9 5618.2 5680.2 5684.6 5686.8 5704.4 5588.5 5721.5 5730.3 5733.9 5735.7 5441.2 5455.8 5459.9 5468.8 5480.8 5448.7 5470.4 5506.1 5576.2 5639.1 5501.1 5519.6 5522.4 5529.6 5535.2 5499.9 5574.1 5639.8 5667.1 5707.0 5464.1 5494.2 5548.9 5574.6 5612.7 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#1] ext.html Cycles:180 Average:46525.63 Median:183808.79 stddev:81460.80 (44.3%) stddev-sans-first:81616.11 11:15:56 INFO - PROCESS | 22926 | Values: 528.6 530.5 533.9 551.4 555.4 34058.8 34941.8 35026.6 35064.8 35072.8 37687.6 37872.0 38005.0 38006.2 38042.6 8373.4 8512.9 8537.0 8539.6 8550.0 8312.4 8352.5 8356.2 8415.4 8418.4 8238.9 8263.1 8282.9 8287.8 8329.1 8557.7 8561.0 8585.5 8586.7 8595.1 8452.0 8456.5 8559.3 8560.2 8561.5 37900.4 38420.0 38462.8 38504.6 38516.2 2971.3 2973.8 3030.1 3248.3 3558.6 27132.6 27244.0 27336.0 27972.4 28568.6 3688.6 3744.2 3782.0 3806.9 3812.0 254058.0 255457.0 255985.0 256941.0 258062.0 50572.2 52016.0 57077.0 57211.7 57604.4 63005.7 64174.7 64188.4 64253.7 64654.4 13037.9 13056.5 13222.1 13234.3 13295.1 10677.8 10696.4 10719.6 10719.9 10725.5 19105.1 19343.5 19363.0 19382.6 19461.8 7324.9 7628.7 7654.4 7660.1 7723.2 935.2 942.9 954.9 1012.7 1051.4 27513.7 27877.2 27901.7 28186.6 28255.9 978.5 1022.5 1037.0 1072.4 1131.7 13586.5 13607.7 13824.4 13840.7 13914.7 364059.0 370954.0 371809.0 372476.0 372913.0 49267.3 49348.8 49365.8 49755.8 49818.0 1270.3 1270.9 1286.6 1293.0 1304.8 23062.9 23219.5 23302.9 23457.5 23480.2 39304.6 39433.8 39626.6 39694.8 39998.2 290571.0 292085.9 292458.0 292764.0 294725.0 29934.4 41142.6 42118.2 42192.8 42405.2 39569.0 40600.4 40691.2 40840.6 41348.2 34139.3 34298.3 34379.8 34568.5 34920.3 32834.8 34427.5 34829.7 34902.5 36581.8 33092.9 33733.5 33901.7 34306.8 34329.3 31055.5 32078.0 32456.8 32613.2 35470.0 23913.9 23940.4 24357.9 24394.0 24528.0 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#2] jquery.html Cycles:180 Average:27268.03 Median:41447.19 stddev:87318.38 (210.7%) stddev-sans-first:87539.94 11:15:56 INFO - PROCESS | 22926 | Values: 353.8 359.4 361.1 362.2 362.3 15541.5 15892.9 16730.7 17478.6 18232.0 10500.9 11083.6 14807.9 14849.3 14897.8 4804.4 4820.4 4932.1 4939.0 4944.5 4856.9 4874.7 4888.6 4897.6 4900.6 4858.6 4964.8 4971.3 5249.7 5438.8 5329.5 5348.6 5352.7 5353.2 5376.1 4816.0 5116.5 5152.8 5295.0 5320.2 13332.5 13357.3 14336.5 20311.3 20572.6 2050.1 2052.5 2068.5 2079.6 2136.4 9262.6 9534.6 9574.2 9691.6 12629.9 1748.9 1796.3 1802.3 1816.8 1818.1 58478.4 58733.1 58753.0 62710.1 62904.1 10257.1 10273.5 10279.7 10296.8 10298.2 13237.5 13302.8 13306.8 13309.9 13324.9 7194.4 7231.3 7241.8 7394.9 7527.7 7208.9 7220.8 7223.2 7235.4 7285.9 4472.2 4551.2 4558.8 4562.8 4585.5 1825.3 1837.2 1838.5 1872.3 1880.0 457.1 468.6 890.7 964.6 979.9 10605.6 11136.4 11164.7 11194.4 11429.7 445.4 476.9 484.6 487.0 489.1 5909.5 6046.7 6079.7 6108.2 6153.2 526183.0 526879.0 527361.0 543102.0 549831.0 41215.0 41440.0 78834.0 80357.4 81112.6 500.8 508.0 510.7 510.9 513.2 9832.8 9997.2 10033.5 10064.2 10317.8 30984.0 30991.0 31444.0 32006.7 32603.7 38772.4 40748.8 41454.4 43882.3 44564.3 9091.9 9494.2 9826.2 10039.8 10088.5 11509.4 11595.4 11616.9 11640.3 15882.9 13552.5 13630.2 13817.7 13857.2 14546.5 11828.5 12903.0 13347.2 14220.4 14382.1 12865.8 15122.6 15138.7 15159.8 15160.4 9733.1 9925.6 9973.5 9977.4 10032.7 14781.3 14841.6 14982.1 15036.9 15311.7 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#3] mootools.html Cycles:180 Average:5199.79 Median:5947.51 stddev:2688.93 (45.2%) stddev-sans-first:2681.14 11:15:56 INFO - PROCESS | 22926 | Values: 1379.1 1400.1 1524.5 1716.4 1721.6 6556.1 6653.7 7122.1 7419.8 7456.3 7060.3 7094.6 7140.4 7152.4 7154.2 2167.7 2192.3 2198.5 2198.9 2200.3 2224.2 2239.6 2303.3 2308.8 2311.0 2216.2 2219.5 2240.8 2247.2 2270.8 2255.7 2259.8 2293.9 2321.6 2327.6 2244.9 2261.4 2267.7 2278.2 2278.8 7466.9 7533.5 7548.2 7572.7 7604.0 4434.8 4485.7 4495.9 4510.9 4541.9 2904.4 2990.7 2999.7 3001.4 3002.4 960.2 963.6 994.3 998.8 1015.4 10354.7 10362.5 10366.1 10368.4 10386.8 4041.5 4104.8 4116.0 4135.2 4161.1 8827.5 8844.7 8885.3 8885.6 8897.3 4578.1 4593.7 4629.6 4645.4 4658.7 4063.3 4123.2 4160.3 4215.8 4222.4 3393.2 3412.9 3414.4 3416.8 3435.8 1054.2 1056.7 1066.1 1068.6 1069.0 954.2 954.2 958.7 1031.6 1274.4 6958.6 7039.8 7067.9 7073.4 7078.6 495.6 1063.7 1103.9 1158.7 1195.2 5475.8 5512.6 5602.9 5602.9 5643.6 8993.1 9123.9 9129.5 9186.1 9224.5 8796.0 8867.8 8886.1 8997.7 9040.0 7035.1 7128.9 7143.9 7163.7 7172.9 6848.7 6861.7 6954.1 6959.3 7001.6 7951.2 8043.0 8059.9 8187.6 8294.9 8246.5 8305.4 8330.2 8387.2 8439.9 5851.4 5945.3 6183.8 6551.1 6625.9 6891.1 6936.5 6948.5 6970.4 6979.5 6421.8 6680.8 6696.6 6774.9 6809.9 6428.2 6488.8 6495.3 6506.2 6518.3 6144.2 6219.0 6236.1 6240.0 6267.8 5856.4 5862.1 5897.3 5931.0 5936.0 5900.6 5949.7 5950.1 5956.5 5982.6 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#4] prototype.html Cycles:180 Average:5506.87 Median:6224.42 stddev:1684.37 (27.1%) stddev-sans-first:1643.68 11:15:56 INFO - PROCESS | 22926 | Values: 331.1 338.3 343.8 344.1 352.8 6132.1 6152.5 6158.4 6167.7 6245.8 6127.1 6152.2 6175.3 6186.6 6210.6 4723.3 4725.8 4726.3 4735.0 4742.0 4718.6 4721.3 4723.9 4726.7 4736.0 4491.4 4532.1 4626.2 4649.6 4674.4 4629.4 4632.6 4656.3 4669.8 4680.3 4022.4 4039.9 4051.0 4065.8 4091.8 5868.6 5872.1 5873.7 5874.5 5881.8 5254.5 5429.2 5456.6 5471.3 5486.0 6536.1 6536.4 6536.8 6546.1 6556.7 4506.8 4515.4 4520.4 4526.5 4540.0 6686.8 6746.8 6765.1 6785.9 6803.5 4630.4 4636.8 4640.0 4641.1 4641.6 4692.6 4693.4 4709.5 4711.2 4716.6 5389.9 5417.1 5422.8 5432.8 5445.9 6414.9 6552.6 6560.6 6593.7 6606.1 1640.6 1646.4 1652.0 1660.0 1662.4 1089.6 1089.7 1101.3 1110.7 1115.7 6238.2 6302.3 6308.9 6315.0 6315.2 6718.8 6751.6 6762.1 6792.8 6818.5 6008.4 6196.8 6247.6 6276.2 6279.1 3659.9 3663.1 3692.8 3705.4 3711.2 7147.6 7212.5 7215.7 7219.0 7239.4 6898.2 6913.1 6984.4 6994.7 7049.2 7215.7 7216.1 7222.6 7225.3 7237.2 6805.1 6844.9 6860.8 6863.1 6893.6 6602.2 6798.0 6800.1 6811.0 6813.2 7154.1 7179.2 7186.1 7204.0 7211.1 4666.7 4671.1 4674.3 4676.1 4677.9 6715.7 6718.5 6858.8 6859.3 6869.3 6679.2 6681.0 6681.5 6685.8 6687.9 6480.5 6629.3 6642.8 6651.1 6663.2 6492.7 6505.5 6524.2 6534.9 6544.7 6644.1 6646.6 6685.7 6699.1 6706.7 6432.4 6473.3 6510.7 6525.2 6552.8 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - PROCESS | 22926 | [#5] yui.html Cycles:180 Average:13092.62 Median:48839.27 stddev:15132.61 (31.0%) stddev-sans-first:15146.69 11:15:56 INFO - PROCESS | 22926 | Values: 752.6 783.4 823.7 835.0 838.8 12770.9 12772.6 12854.2 12974.1 13010.7 12302.0 12312.1 12338.3 12350.8 12363.3 753.9 766.9 786.5 800.2 802.3 772.8 780.1 782.4 783.9 784.4 824.2 828.0 833.6 834.7 835.4 822.8 823.7 824.9 825.0 825.7 604.3 605.6 608.5 608.6 610.2 12459.1 12478.9 12548.4 12583.1 12613.9 11136.2 11195.9 11262.2 11349.4 11605.8 10043.2 10095.6 10100.2 10120.7 10204.4 3548.9 3562.8 3568.8 3607.5 3686.4 48207.8 48828.3 48850.3 48997.8 49294.0 8856.8 8923.3 9193.8 9464.3 9683.8 17432.0 17434.5 17447.7 17471.6 17471.7 6739.0 6765.7 6813.1 6918.0 7008.6 4034.7 4064.3 4110.5 4181.3 4282.5 2964.0 2980.5 2988.6 2989.1 3006.6 500.6 504.9 514.2 516.3 529.8 557.4 557.5 607.2 614.8 668.0 8409.7 8417.0 8445.6 8563.8 8749.1 504.9 579.6 583.8 668.9 678.1 3755.1 4020.0 4076.8 4187.2 4199.3 52751.2 52892.0 53055.0 53262.7 53497.2 47412.3 47711.5 47720.3 47805.0 49318.3 41723.4 42088.2 43134.6 44675.3 44818.0 8210.6 8387.7 8561.5 8616.1 8763.1 31070.4 31878.0 31973.2 34350.3 34509.3 42298.2 42476.8 42580.6 42936.6 43038.8 10239.0 10452.6 10734.3 10937.7 11032.6 11305.3 11546.9 11567.6 11701.1 11853.3 9455.2 9875.4 9884.7 9956.0 9964.8 10789.8 10812.2 10849.5 10903.7 11217.3 10211.5 10419.8 10568.4 10798.4 10803.5 8739.9 8791.8 8891.2 9204.6 9317.8 8478.2 9388.8 9466.1 9558.0 9642.1 11:15:56 INFO - PROCESS | 22926 | -------- Summary: end -------- 11:15:56 INFO - PROCESS | 22926 | 11:15:56 INFO - TEST-INFO | 22926: exit 0 11:15:56 INFO - TEST-OK | dromaeo_css | took 1110569ms 11:15:56 INFO - TEST-START | kraken 11:15:56 INFO - operating with platform_type : linux_ 11:15:56 INFO - Initialising browser for kraken test... 11:15:56 INFO - TEST-INFO | started process 23166 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgzP9kL/profile http://localhost:51498/getInfo.html) 11:16:00 INFO - PROCESS | 23166 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 11:16:00 INFO - PROCESS | 23166 | __metrics Screen width/height:1600/1200 11:16:00 INFO - PROCESS | 23166 | colorDepth:24 11:16:00 INFO - PROCESS | 23166 | Browser inner width/height: 1024/697 11:16:00 INFO - PROCESS | 23166 | __metrics 11:16:01 INFO - PROCESS | 23166 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:16:01 INFO - TEST-INFO | 23166: exit 0 11:16:01 INFO - Browser initialized. 11:16:01 INFO - Running cycle 1/1 for kraken test... 11:16:01 INFO - TEST-INFO | started process 23291 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgzP9kL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:13 INFO - PROCESS | 23291 | RSS: Main: 150478848 11:16:13 INFO - PROCESS | 23291 | 11:16:16 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51498/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:16 INFO - PROCESS | 23291 | RSS: Main: 151060480 11:16:16 INFO - PROCESS | 23291 | 11:16:19 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51498/tests/kraken/driver.html?testName=audio-dft) 11:16:19 INFO - PROCESS | 23291 | RSS: Main: 152039424 11:16:19 INFO - PROCESS | 23291 | 11:16:22 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51498/tests/kraken/driver.html?testName=audio-fft) 11:16:23 INFO - PROCESS | 23291 | RSS: Main: 146513920 11:16:23 INFO - PROCESS | 23291 | 11:16:25 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51498/tests/kraken/driver.html?testName=audio-oscillator) 11:16:25 INFO - PROCESS | 23291 | RSS: Main: 145981440 11:16:25 INFO - PROCESS | 23291 | 11:16:28 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:28 INFO - PROCESS | 23291 | RSS: Main: 146751488 11:16:28 INFO - PROCESS | 23291 | 11:16:31 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51498/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:32 INFO - PROCESS | 23291 | RSS: Main: 148070400 11:16:32 INFO - PROCESS | 23291 | 11:16:35 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51498/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:36 INFO - PROCESS | 23291 | RSS: Main: 147951616 11:16:36 INFO - PROCESS | 23291 | 11:16:39 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51498/tests/kraken/driver.html?testName=json-parse-financial) 11:16:39 INFO - PROCESS | 23291 | RSS: Main: 148365312 11:16:39 INFO - PROCESS | 23291 | 11:16:41 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:41 INFO - PROCESS | 23291 | RSS: Main: 147943424 11:16:41 INFO - PROCESS | 23291 | 11:16:43 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:44 INFO - PROCESS | 23291 | RSS: Main: 148439040 11:16:44 INFO - PROCESS | 23291 | 11:16:46 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:47 INFO - PROCESS | 23291 | RSS: Main: 148951040 11:16:47 INFO - PROCESS | 23291 | 11:16:49 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:50 INFO - PROCESS | 23291 | RSS: Main: 148475904 11:16:50 INFO - PROCESS | 23291 | 11:16:52 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:53 INFO - PROCESS | 23291 | RSS: Main: 148406272 11:16:53 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | Cycle 1(1): loaded http://localhost:51498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51498/tests/kraken/driver.html?testName=ai-astar) 11:16:55 INFO - PROCESS | 23291 | RSS: Main: 149745664 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | __start_tp_report 11:16:55 INFO - PROCESS | 23291 | _x_x_mozilla_page_load 11:16:55 INFO - PROCESS | 23291 | _x_x_mozilla_page_load_details 11:16:55 INFO - PROCESS | 23291 | |i|pagename|runs| 11:16:55 INFO - PROCESS | 23291 | |0;ai-astar;111;105;112;110;111;123;111;111;110;110 11:16:55 INFO - PROCESS | 23291 | |1;audio-beat-detection;156;128;151;169;124;151;148;130;169;128 11:16:55 INFO - PROCESS | 23291 | |2;audio-dft;165;163;161;163;162;162;161;164;174;163 11:16:55 INFO - PROCESS | 23291 | |3;audio-fft;71;75;72;73;72;72;139;74;74;71 11:16:55 INFO - PROCESS | 23291 | |4;audio-oscillator;100;96;143;97;97;97;151;97;96;146 11:16:55 INFO - PROCESS | 23291 | |5;imaging-gaussian-blur;111;110;111;109;109;110;110;110;110;110 11:16:55 INFO - PROCESS | 23291 | |6;imaging-darkroom;147;146;147;147;146;146;147;147;147;147 11:16:55 INFO - PROCESS | 23291 | |7;imaging-desaturate;96;97;97;97;97;97;96;97;97;96 11:16:55 INFO - PROCESS | 23291 | |8;json-parse-financial;61;61;63;60;61;69;60;65;60;58 11:16:55 INFO - PROCESS | 23291 | |9;json-stringify-tinderbox;69;68;68;68;69;68;68;70;69;68 11:16:55 INFO - PROCESS | 23291 | |10;stanford-crypto-aes;86;88;94;88;86;87;87;89;89;87 11:16:55 INFO - PROCESS | 23291 | |11;stanford-crypto-ccm;120;125;123;138;121;120;128;120;126;131 11:16:55 INFO - PROCESS | 23291 | |12;stanford-crypto-pbkdf2;147;153;162;166;150;148;157;154;151;142 11:16:55 INFO - PROCESS | 23291 | |13;stanford-crypto-sha256-iterative;69;70;70;70;72;68;69;69;67;69 11:16:55 INFO - PROCESS | 23291 | __end_tp_report 11:16:55 INFO - PROCESS | 23291 | __start_cc_report 11:16:55 INFO - PROCESS | 23291 | _x_x_mozilla_cycle_collect,739 11:16:55 INFO - PROCESS | 23291 | __end_cc_report 11:16:55 INFO - PROCESS | 23291 | __startTimestamp1452107815304__endTimestamp 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | ------- Summary: start ------- 11:16:55 INFO - PROCESS | 23291 | Number of tests: 14 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.50 (4.1%) stddev-sans-first:4.77 11:16:55 INFO - PROCESS | 23291 | Values: 111.0 105.0 112.0 110.0 111.0 123.0 111.0 111.0 110.0 110.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:16.98 (11.2%) stddev-sans-first:17.58 11:16:55 INFO - PROCESS | 23291 | Values: 156.0 128.0 151.0 169.0 124.0 151.0 148.0 130.0 169.0 128.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.79 (2.3%) stddev-sans-first:4.00 11:16:55 INFO - PROCESS | 23291 | Values: 165.0 163.0 161.0 163.0 162.0 162.0 161.0 164.0 174.0 163.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#3] audio-fft Cycles:10 Average:79.30 Median:72.50 stddev:21.02 (29.0%) stddev-sans-first:22.08 11:16:55 INFO - PROCESS | 23291 | Values: 71.0 75.0 72.0 73.0 72.0 72.0 139.0 74.0 74.0 71.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:96.50 stddev:24.02 (24.9%) stddev-sans-first:25.08 11:16:55 INFO - PROCESS | 23291 | Values: 100.0 96.0 143.0 97.0 97.0 97.0 151.0 97.0 96.0 146.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 11:16:55 INFO - PROCESS | 23291 | Values: 111.0 110.0 111.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:16:55 INFO - PROCESS | 23291 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:16:55 INFO - PROCESS | 23291 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 96.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:61.00 stddev:3.16 (5.2%) stddev-sans-first:3.33 11:16:55 INFO - PROCESS | 23291 | Values: 61.0 61.0 63.0 60.0 61.0 69.0 60.0 65.0 60.0 58.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 11:16:55 INFO - PROCESS | 23291 | Values: 69.0 68.0 68.0 68.0 69.0 68.0 68.0 70.0 69.0 68.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:2.33 (2.6%) stddev-sans-first:2.35 11:16:55 INFO - PROCESS | 23291 | Values: 86.0 88.0 94.0 88.0 86.0 87.0 87.0 89.0 89.0 87.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:125.50 stddev:5.87 (4.7%) stddev-sans-first:5.91 11:16:55 INFO - PROCESS | 23291 | Values: 120.0 125.0 123.0 138.0 121.0 120.0 128.0 120.0 126.0 131.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:153.50 stddev:7.16 (4.7%) stddev-sans-first:7.26 11:16:55 INFO - PROCESS | 23291 | Values: 147.0 153.0 162.0 166.0 150.0 148.0 157.0 154.0 151.0 142.0 11:16:55 INFO - PROCESS | 23291 | 11:16:55 INFO - PROCESS | 23291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.34 (1.9%) stddev-sans-first:1.41 11:16:55 INFO - PROCESS | 23291 | Values: 69.0 70.0 70.0 70.0 72.0 68.0 69.0 69.0 67.0 69.0 11:16:55 INFO - PROCESS | 23291 | -------- Summary: end -------- 11:16:55 INFO - PROCESS | 23291 | 11:16:56 INFO - TEST-INFO | 23291: exit 0 11:16:56 INFO - TEST-OK | kraken | took 59355ms 11:16:56 INFO - TEST-START | v8_7 11:16:56 INFO - operating with platform_type : linux_ 11:16:56 INFO - Initialising browser for v8_7 test... 11:16:56 INFO - TEST-INFO | started process 23580 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7knZ77/profile http://localhost:51498/getInfo.html) 11:16:59 INFO - PROCESS | 23580 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 11:17:00 INFO - PROCESS | 23580 | __metrics Screen width/height:1600/1200 11:17:00 INFO - PROCESS | 23580 | colorDepth:24 11:17:00 INFO - PROCESS | 23580 | Browser inner width/height: 1024/697 11:17:00 INFO - PROCESS | 23580 | __metrics 11:17:00 INFO - PROCESS | 23580 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:17:01 INFO - TEST-INFO | 23580: exit 0 11:17:01 INFO - Browser initialized. 11:17:01 INFO - Running cycle 1/1 for v8_7 test... 11:17:01 INFO - TEST-INFO | started process 23703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7knZ77/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:12 INFO - PROCESS | 23703 | RSS: Main: 151031808 11:17:12 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | Cycle 1(1): loaded http://localhost:51498/tests/v8_7/run.html (next: http://localhost:51498/tests/v8_7/run.html) 11:17:34 INFO - PROCESS | 23703 | RSS: Main: 147378176 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | __start_tp_report 11:17:34 INFO - PROCESS | 23703 | _x_x_mozilla_page_load 11:17:34 INFO - PROCESS | 23703 | _x_x_mozilla_page_load_details 11:17:34 INFO - PROCESS | 23703 | |i|pagename|runs| 11:17:34 INFO - PROCESS | 23703 | |0;Richards;167.61649346295675 11:17:34 INFO - PROCESS | 23703 | |1;DeltaBlue;189.5734597156398 11:17:34 INFO - PROCESS | 23703 | |2;Encrypt;279.56388034665923 11:17:34 INFO - PROCESS | 23703 | |3;Decrypt;5218.75 11:17:34 INFO - PROCESS | 23703 | |4;RayTrace;1092.896174863388 11:17:34 INFO - PROCESS | 23703 | |5;Earley;722.543352601156 11:17:34 INFO - PROCESS | 23703 | |6;Boyer;12256.09756097561 11:17:34 INFO - PROCESS | 23703 | |7;RegExp;25200 11:17:34 INFO - PROCESS | 23703 | |8;Splay;633.5012594458439 11:17:34 INFO - PROCESS | 23703 | |9;NavierStokes;4850.241545893719 11:17:34 INFO - PROCESS | 23703 | __end_tp_report 11:17:34 INFO - PROCESS | 23703 | __startTimestamp1452107854634__endTimestamp 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | ------- Summary: start ------- 11:17:34 INFO - PROCESS | 23703 | Number of tests: 10 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 167.6 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#1] DeltaBlue Cycles:1 Average:189.57 Median:189.57 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 189.6 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 279.6 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 5218.8 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#4] RayTrace Cycles:1 Average:1092.90 Median:1092.90 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 1092.9 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#5] Earley Cycles:1 Average:722.54 Median:722.54 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 722.5 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 12256.1 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 25200.0 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#8] Splay Cycles:1 Average:633.50 Median:633.50 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 633.5 11:17:34 INFO - PROCESS | 23703 | 11:17:34 INFO - PROCESS | 23703 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:17:34 INFO - PROCESS | 23703 | Values: 4850.2 11:17:34 INFO - PROCESS | 23703 | -------- Summary: end -------- 11:17:34 INFO - PROCESS | 23703 | 11:17:35 INFO - TEST-INFO | 23703: exit 0 11:17:35 INFO - TEST-OK | v8_7 | took 39287ms 11:17:35 INFO - SUITE-END | took 1209s 11:17:35 INFO - Completed test suite (00:20:09) 11:17:35 INFO - Working with test: dromaeo_css 11:17:35 INFO - Generating results file: dromaeo_css 11:17:35 INFO - Working with test: kraken 11:17:35 INFO - Generating results file: kraken 11:17:35 INFO - javascript benchmark 11:17:35 INFO - Working with test: v8_7 11:17:35 INFO - Generating results file: v8_7 11:17:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:17:35 INFO - process_Request line: dromaeo_css 6738.97 graph.html#tests=[[72,64,43]] 11:17:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:35 INFO - process_Request line: kraken 1531.20 graph.html#tests=[[232,64,43]] 11:17:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:17:35 INFO - process_Request line: v8_7 21153.49 graph.html#tests=[[230,64,43]] 11:17:35 INFO - RETURN: dromaeo_css: 6738.97 11:17:35 INFO - RETURN: kraken: 1531.20 11:17:35 INFO - RETURN: v8_7: 21153.49 11:17:35 INFO - javascript benchmark 11:17:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3115.6105486814154, 3156.479180935146, 3185.697358750918, 3188.585483887094, 3201.0396880935714, 5155.587552995761, 5328.733563321833, 5353.91969120463, 5355.866103347418, 5358.571314294857, 5245.973770131153, 5254.7635356408955, 5276.894462110765, 5314.468553144684, 5334.706591137486, 4814.951850481494, 4874.049560335736, 4908.067467181224, 4941.061198372316, 4996.5503104720565, 4872.8050877965015, 4913.778879950393, 4923.876903077416, 4996.600271978251, 5006.173981293082, 4743.0988112258565, 4812.109759694467, 4818.975905120487, 4887.120318342697, 4927.014597080581, 4858.344123543312, 4881.707097574122, 4905.043516514281, 4916.336294600219, 4917.065757506098, 4864.124457597631, 4883.096627123993, 4891.046245982035, 4895.461499235082, 4897.363342765453, 5061.5950723942, 5109.3613298337705, 5121.052605268037, 5151.17581187012, 5225.268462415265, 5781.277340332458, 5790.449907258803, 5793.246877905887, 5801.564882633777, 5803.9709801451145, 5816.0, 5830.62100963436, 5837.270341207349, 5839.708014599253, 5843.2695913010875, 5194.402643695986, 5302.098643230622, 5347.064263753867, 5381.461853814626, 5483.561315094863, 5815.854603634943, 5820.417958204146, 5851.21008663825, 5852.15143804146, 5868.882622347529, 5595.7481913313995, 5614.9612321720615, 5617.269754931833, 5622.353429355595, 5624.634398764068, 5518.475744804237, 5565.638233514808, 5614.494695477427, 5616.550675945915, 5684.033714268584, 5656.179853921159, 5691.26013618227, 5711.343195532484, 5713.228714123623, 5742.138679198154, 5673.574481913873, 5692.459216374438, 5702.600817942787, 5737.540996720252, 5755.079187330007, 4306.913861722748, 4415.050764085737, 4419.027813880941, 4431.313146462304, 4535.29702896045, 3938.6455219030427, 3952.466417033721, 3959.148783011666, 3981.960180398217, 3983.64147226751, 5418.078926582491, 5418.756155972991, 5442.564594832483, 5444.727763611803, 5448.155535891943, 5604.635698679573, 5625.718714064362, 5689.516391106719, 5693.544516438675, 5694.345150307685, 5267.868303292448, 5299.973500132474, 5307.363116425976, 5310.7610157543, 5314.4951229633125, 4810.4467986181335, 4819.879503012453, 4820.734859582686, 4899.58353539946, 4983.127952608352, 5791.855203619859, 5801.854953626109, 5835.474807267281, 5878.647281163058, 5981.312149102909, 5648.124540696199, 5708.771649133988, 5711.257536520309, 5719.742611582572, 5737.655740655574, 5760.452756988079, 5785.132230165509, 5991.310999234969, 6024.728887199999, 6045.939540604538, 5618.157276408571, 5680.233168522362, 5684.63049901755, 5686.800961966312, 5704.401037891128, 5588.524975376976, 5721.542276617944, 5730.255066841284, 5733.885322293614, 5735.684537350486, 5441.21102440136, 5455.754491047833, 5459.863503412287, 5468.753906074316, 5480.780768769205, 5448.727563621724, 5470.370907345706, 5506.063969125178, 5576.163575463551, 5639.097744360883, 5501.119820828648, 5519.586031047767, 5522.447755224606, 5529.612927095065, 5535.197396377584, 5499.945000549943, 5574.080276754452, 5639.774409023593, 5667.093265077568, 5707.0, 5464.098423760194, 5494.1758736189895, 5548.889022219614, 5574.554035677217, 5612.691301978431], "unit": "score", "name": "dojo.html", "value": 5264.925338685037}, {"lowerIsBetter": false, "replicates": [528.6114705691317, 530.5198795090442, 533.8852146788437, 551.4237621685339, 555.4334578729694, 34058.829705851465, 34941.82529087351, 35026.64973350266, 35064.82467587662, 35072.82463587685, 37687.62312376875, 37872.0, 38005.0, 38006.23987520248, 38042.61957380425, 8373.371997100227, 8512.935883014623, 8537.0, 8539.573021348939, 8549.95725021374, 8312.41813073082, 8352.457090289143, 8356.247937685606, 8415.368847336444, 8418.368622353317, 8238.917610823875, 8263.091059983397, 8282.917170828276, 8287.751367458986, 8329.08380078191, 8557.700480483185, 8560.957195214016, 8585.484870907703, 8586.742397728047, 8595.140485951417, 8452.0, 8456.450330728483, 8559.27246184075, 8560.229579337827, 8561.48631082137, 37900.43149352762, 38420.0, 38462.807685961394, 38504.61495385038, 38516.229675406335, 2971.286891146131, 2973.821570705743, 3030.1364111228195, 3248.30161515273, 3558.5729712434672, 27132.59301110485, 27244.0, 27336.0, 27972.440551189065, 28568.571471427946, 3688.61269566697, 3744.1949980754, 3782.0, 3806.90482737931, 3811.9707678926534, 254058.0, 255457.0, 255985.0, 256941.0, 258062.0, 50572.24141637805, 52016.0, 57077.0, 57211.713941430025, 57604.42395576074, 63005.68497157576, 64174.67912660407, 64188.35811641917, 64253.67873160604, 64654.353456465775, 13037.869621303855, 13056.477740890448, 13222.074454788073, 13234.272115033573, 13295.135816171918, 10677.78644427107, 10696.41169735672, 10719.624813131502, 10719.946400267949, 10725.517351719036, 19105.14026868794, 19343.51641208981, 19363.0, 19382.612347752965, 19461.805381946284, 7324.926750732531, 7628.656710448043, 7654.387648988068, 7660.119086305146, 7723.150453450228, 935.2377812083131, 942.9009953954874, 954.8519979403204, 1012.7215015870547, 1051.4374809476892, 27513.72486275152, 27877.163685089075, 27901.720982790317, 28186.577201341996, 28255.858720706266, 978.471625322318, 1022.5407894014907, 1037.0, 1072.372661992743, 1131.6944425005202, 13586.456541738418, 13607.727845443036, 13824.447022119002, 13840.653983650287, 13914.652133696536, 364059.0, 370954.0, 371809.0, 372476.0, 372913.0, 49267.26099108516, 49348.75325623349, 49365.75317123391, 49755.75122124366, 49818.0, 1270.339423499775, 1270.9364531773374, 1286.6140157952577, 1293.049608537724, 1304.8238487804024, 23062.884685576464, 23219.535609288057, 23302.883485582464, 23457.53084938326, 23480.178193763135, 39304.606953930095, 39433.80283098566, 39626.60373396229, 39694.80152599219, 39998.2000359997, 290571.0, 292085.935273562, 292458.0, 292764.0, 294725.0, 29934.401311974074, 41142.58857411388, 42118.15763684648, 42192.78903605462, 42405.1518969625, 39569.0, 40600.390994135705, 40691.18617627572, 40840.59159408368, 41348.1730365385, 34139.31721365509, 34298.31403371968, 34379.82810085933, 34568.48147277843, 34920.30159396747, 32834.835825820715, 34427.483587746705, 34829.65170348264, 34902.476462853585, 36581.817090914374, 33092.85617866299, 33733.49399759054, 33901.66098338985, 34306.828465857514, 34329.31341373209, 31055.534166987964, 32078.0, 32456.83771581127, 32613.18467038343, 35470.0, 23913.880430597736, 23940.40148996289, 24357.878210608833, 24394.0, 24528.0], "unit": "score", "name": "ext.html", "value": 17753.037239985166}, {"lowerIsBetter": false, "replicates": [353.8142475200521, 359.3764818040699, 361.1278761790277, 362.21038136861637, 362.3170323939373, 15541.456049038286, 15892.920535397321, 16730.66538669226, 17478.563035924108, 18232.0, 10500.947495262513, 11083.556657733681, 14807.92596037021, 14849.257537123154, 14897.77653335201, 4804.375431193948, 4820.421549414075, 4932.112219800434, 4939.0, 4944.480829512903, 4856.878578035542, 4874.707517548941, 4888.633352498577, 4897.608191344684, 4900.558949694527, 4858.635602329822, 4964.826231081895, 4971.304017437562, 5249.685018898859, 5438.83683489496, 5329.520343169133, 5348.572114230852, 5352.705601191933, 5353.170258609922, 5376.11294136467, 4815.975920120412, 5116.539511443951, 5152.845414637567, 5294.973525132388, 5320.228566857784, 13332.533361332404, 13357.33213339329, 14336.49822256216, 20311.28910488126, 20572.5885482291, 2050.1286953044896, 2052.5279185787203, 2068.534579719566, 2079.6152711748373, 2136.401807493904, 9262.583183756748, 9534.618615255451, 9574.186194173504, 9691.563879625433, 12629.873701263054, 1748.8950662960135, 1796.3084212578121, 1802.3331367394017, 1816.7547381103514, 1818.1454716283326, 58478.41521584772, 58733.11900321498, 58753.0, 62710.0593491098, 62904.05643915391, 10257.128144107834, 10273.537690803782, 10279.691609251735, 10296.845547316796, 10298.17614590831, 13237.470501179845, 13302.800457992944, 13306.800397994039, 13309.866901331057, 13324.933375333256, 7194.38847697941, 7231.349178573953, 7241.782746517613, 7394.926050739531, 7527.698892044366, 7208.855822883513, 7220.819479512949, 7223.205447400782, 7235.384992275715, 7285.927140728525, 4472.217361961643, 4551.203539380661, 4558.772061396917, 4562.840300589463, 4585.541445855454, 1825.302468704118, 1837.2191818477095, 1838.5311745505078, 1872.279172518563, 1880.0, 457.1223251357402, 468.59421734795615, 890.7238755985666, 964.623796719266, 979.9167070798919, 10605.628802991858, 11136.38749868765, 11164.720881978015, 11194.384308862927, 11429.657110286538, 445.39648775908825, 476.9332293478916, 484.62925861715814, 486.99756501217973, 489.13667377079486, 5909.527237820964, 6046.697665116727, 6079.726412311456, 6108.175396321529, 6153.1693221415435, 526183.0, 526879.0, 527361.0, 543102.0, 549831.0, 41215.0, 41440.0, 78834.0, 80357.39285214263, 81112.59443702744, 500.7646406189085, 507.99492005080214, 510.71144803186826, 510.8544064941474, 513.1558586125802, 9832.801759147493, 9997.150242229493, 10033.548490318099, 10064.163143496642, 10317.793644127225, 30984.0, 30991.0, 31444.0, 32006.6799332013, 32603.673963260062, 38772.41841372438, 40748.79625601853, 41454.37818432786, 43882.341764872916, 44564.331535027646, 9091.863622045543, 9494.192993595345, 9826.213902887896, 10039.849402258826, 10088.495575221357, 11509.36698481558, 11595.420228988685, 11616.941915290707, 11640.301581905112, 15882.920585397, 13552.457901683822, 13630.182189068688, 13817.723645527234, 13857.237851917838, 14546.4908728194, 11828.467718952495, 12903.0, 13347.199168049949, 14220.431182752574, 14382.137071775727, 12865.807012894627, 15122.621934451287, 15138.697226055638, 15159.772603411178, 15160.422728136464, 9733.124018838338, 9925.602975880884, 9973.451460169761, 9977.401355918668, 10032.749181270527, 14781.260936953324, 14841.628959275673, 14982.101073935599, 15036.924815376291, 15311.693766124838], "unit": "score", "name": "jquery.html", "value": 7856.504540379519}, {"lowerIsBetter": false, "replicates": [1379.1173648864728, 1400.1039334825712, 1524.5121561100452, 1716.4421562992031, 1721.561001944504, 6556.082148499214, 6653.667316634161, 7122.074130363058, 7419.777406677795, 7456.32893039627, 7060.258672839342, 7094.609796461193, 7140.428765698744, 7152.3920466760255, 7154.177269613996, 2167.6531754919215, 2192.331338941622, 2198.4723666320047, 2198.923037693681, 2200.2849074050996, 2224.22152246714, 2239.6304609739373, 2303.34354708908, 2308.8268379871492, 2310.953780924389, 2216.1689366487567, 2219.511707424364, 2240.843140980132, 2247.2471721973156, 2270.7842754938256, 2255.6842042114117, 2259.841811073209, 2293.9311820645407, 2321.58211521926, 2327.592671282519, 2244.9214277500373, 2261.4459457432868, 2267.7392099908557, 2278.225403362848, 2278.840481166319, 7466.925330746677, 7533.472656914018, 7548.169701332849, 7572.734954276629, 7604.0, 4434.756088415136, 4485.686001979862, 4495.865124046284, 4510.932336014962, 4541.909161816779, 2904.390078083605, 2990.6710261871176, 2999.7150270724246, 3001.429728351628, 3002.369502404498, 960.2030314838668, 963.5904740485336, 994.318891559277, 998.8451789972565, 1015.3603229965148, 10354.741131471697, 10362.533685984225, 10366.06705396518, 10368.377897326109, 10386.79226415475, 4041.535223449282, 4104.774237416971, 4115.97942010294, 4135.214309281227, 4161.126163505637, 8827.514486703292, 8844.734657960144, 8885.333599980027, 8885.600147993357, 8897.28821694276, 4578.107269082497, 4593.701409408378, 4629.629629629621, 4645.442546894326, 4658.673892827537, 4063.2889244382113, 4123.154753275571, 4160.313548264502, 4215.810288537024, 4222.408862759216, 3393.168673674916, 3412.863485460554, 3414.385410626111, 3416.7779094359284, 3435.845386957593, 1054.1935419404163, 1056.6882769582992, 1066.0991462214417, 1068.58859339155, 1069.04320633033, 954.1746389373142, 954.2127744610724, 958.7459323279337, 1031.6492392586556, 1274.350081458463, 6958.582485050812, 7039.824004399931, 7067.858642827217, 7073.363397294268, 7078.575285482888, 495.5911373117121, 1063.6543123484898, 1103.9448027598587, 1158.6813626252679, 1195.2290772451893, 5475.808346707926, 5512.5589952804485, 5602.915956260659, 5602.943970560324, 5643.5767317451355, 8993.055729148346, 9123.908760912305, 9129.45223286605, 9186.127317904788, 9224.53877306132, 8796.032436431988, 8867.778305542284, 8886.066962968924, 8997.730068097968, 9040.0, 7035.12060992376, 7128.92871071293, 7143.857122857514, 7163.67763450646, 7172.856542869114, 6848.7260509579055, 6861.656917154022, 6954.095967524189, 6959.338862808025, 7001.579905205704, 7951.165127661744, 8043.0, 8059.879101813361, 8187.590620468834, 8294.917050829414, 8246.505209687439, 8305.377096717892, 8330.208630180123, 8387.203215694499, 8439.915600844159, 5851.414858514115, 5945.316288626863, 6183.84540386494, 6551.148350714377, 6625.900611490735, 6891.138607674041, 6936.4797640176175, 6948.513604047668, 6970.372666460043, 6979.511434199558, 6421.839454013687, 6680.799576012728, 6696.631685257357, 6774.898376524257, 6809.8638027238185, 6428.19647544057, 6488.772892948913, 6495.253045899782, 6506.186726659168, 6518.348165183444, 6144.170536977451, 6219.036049412348, 6236.126942228001, 6240.00159974402, 6267.780627678009, 5856.4143585641095, 5862.12068189775, 5897.292324921037, 5930.970345148419, 5935.970320148372, 5900.616459930091, 5949.702514874152, 5950.137230101524, 5956.523478121827, 5982.611130276518], "unit": "score", "name": "mootools.html", "value": 4279.519419142723}, {"lowerIsBetter": false, "replicates": [331.14068990968434, 338.29296769751215, 343.8315225539486, 344.10361009570056, 352.7883270037976, 6132.110843927628, 6152.477039451641, 6158.384161583839, 6167.722452489632, 6245.781397651083, 6127.142200091979, 6152.230971128609, 6175.289841668198, 6186.628802271867, 6210.627362358262, 4723.338732577442, 4725.787339569728, 4726.291056341542, 4735.029318989599, 4742.027884283731, 4718.598919091882, 4721.315409265654, 4723.929141062887, 4726.7400292983875, 4736.0, 4491.371208030879, 4532.116237333721, 4626.21354369758, 4649.558291962258, 4674.415698037746, 4629.3518907353, 4632.606228470601, 4656.278276867074, 4669.766511674403, 4680.297955306732, 4022.3966405039187, 4039.8586049488126, 4051.027753339207, 4065.7763822989723, 4091.754494730326, 5868.559858010666, 5872.060470324727, 5873.709253391138, 5874.50066744323, 5881.823545293648, 5254.500822421864, 5429.212764149216, 5456.563474921997, 5471.343438787371, 5486.0, 6536.052272420472, 6536.41172294491, 6536.836579085513, 6546.116274302955, 6556.737730490775, 4506.752128632924, 4515.367848501212, 4520.367148599166, 4526.547345265447, 4539.954600453986, 6686.765963191265, 6746.797596072126, 6765.120534330555, 6785.898211526831, 6803.523753337268, 4630.3748993886065, 4636.79134438951, 4639.976800115978, 4641.118187544424, 4641.559051890065, 4692.601128904013, 4693.366395536627, 4709.529047095331, 4711.151992641289, 4716.622670186377, 5389.946100539023, 5417.10617748075, 5422.8373148805595, 5432.782688692408, 5445.945540544623, 6414.8717025659225, 6552.639604821685, 6560.606363618198, 6593.703283352261, 6606.141201643852, 1640.6144556029324, 1646.4319809665647, 1651.9917400413162, 1659.9874076813135, 1662.3599914033184, 1089.6131873185063, 1089.6676513663251, 1101.2841652925663, 1110.722319420145, 1115.7210697325668, 6238.220222472191, 6302.338254483213, 6308.873822523616, 6315.0, 6315.242170939517, 6718.824205764069, 6751.628660423626, 6762.120924279812, 6792.8301792454595, 6818.522703410714, 6008.399160083956, 6196.752129914753, 6247.625142491374, 6276.152719382916, 6279.058141278753, 3659.8902032939054, 3663.084228942764, 3692.7968961707365, 3705.444183372516, 3711.2206436648607, 7147.64261786919, 7212.531185472927, 7215.71137154508, 7219.0, 7239.420846332281, 6898.172219333712, 6913.0667359905765, 6984.371406573331, 6994.650267486605, 7049.224585295613, 7215.67529461165, 7216.134063912364, 7222.566646001257, 7225.277472252733, 7237.203907570163, 6805.115335006418, 6844.93155068443, 6860.794176174722, 6863.10779598649, 6893.551919125442, 6602.1747281589805, 6798.014287928124, 6800.081988931431, 6811.0, 6813.216480104653, 7154.069970903957, 7179.246179151114, 7186.1376634804155, 7204.0, 7211.134663840373, 4666.743329116931, 4671.065786842577, 4674.298855171752, 4676.088162808356, 4677.906441871075, 6715.664216789043, 6718.462522998051, 6858.759943401957, 6859.348361905611, 6869.278725733726, 6679.2318883329035, 6681.0, 6681.498887583548, 6685.76599819004, 6687.899681504879, 6480.513961452815, 6629.337066293332, 6642.83392915181, 6651.06885036105, 6663.200415949923, 6492.707828147839, 6505.51208659343, 6524.1518602583255, 6534.901976470262, 6544.6727663615675, 6644.136262285871, 6646.60120392778, 6685.732570697312, 6699.09562209115, 6706.698198580978, 6432.35676432353, 6473.255575608865, 6510.73957041732, 6525.151730275224, 6552.803415897531], "unit": "score", "name": "prototype.html", "value": 4956.561102346702}, {"lowerIsBetter": false, "replicates": [752.6387334079642, 783.4006984656738, 823.7207705967497, 834.9980023971236, 838.7651457591872, 12770.872291277085, 12772.552960646379, 12854.16447930885, 12974.091813573054, 13010.739785204301, 12302.0, 12312.13815032948, 12338.259704417718, 12350.752984940296, 12363.258204507736, 753.8680730872089, 766.9194734552875, 786.4848524216648, 800.1558355934516, 802.2819576479047, 772.8145245141154, 780.063923292049, 782.3819182845574, 783.9216078392172, 784.4391260248921, 824.2334628795218, 828.035338830262, 833.5832083958021, 834.7287131682198, 835.4444294544121, 822.8066404394963, 823.7322870067252, 824.8968878890139, 824.9770284846746, 825.7110011495988, 604.3261763134118, 605.6366180291834, 608.4523928464417, 608.5800797449746, 610.2006371653149, 12459.12786104973, 12478.937605312007, 12548.435320410603, 12583.119181657288, 12613.936930315382, 11136.220464567483, 11195.944020279929, 11262.21164518484, 11349.43252837363, 11605.825912611317, 10043.246756493292, 10095.596176152945, 10100.191984641284, 10120.746981325452, 10204.438755868425, 3548.9112772180642, 3562.8218589070443, 3568.839402226906, 3607.549056367954, 3686.3548878946344, 48207.75896120497, 48828.267575986385, 48850.26724599134, 48997.75501122472, 49294.0, 8856.822863542693, 8923.286137109015, 9193.816123677489, 9464.337496375188, 9683.757906052406, 17432.0, 17434.47696569105, 17447.73828392575, 17471.56321091983, 17471.65056698859, 6738.966305168443, 6765.695543700545, 6813.148356455443, 6918.0, 7008.614526201108, 4034.65705415043, 4064.3293856513937, 4110.527289361702, 4181.330987042059, 4282.528921818597, 2963.9703602963696, 2980.478416277143, 2988.581598576201, 2989.0584465893176, 3006.6392032956187, 500.56951022120944, 504.8788290810179, 514.182449904646, 516.2901011109724, 529.7721979548754, 557.3896583241344, 557.5483858074972, 607.2470137030051, 614.8063360041573, 667.9732810687615, 8409.663613455516, 8417.0, 8445.57772111392, 8563.785905352415, 8749.1250874912, 504.85863958091795, 579.6000759475949, 583.7578544668813, 668.9062639355565, 678.1353773938268, 3755.1363186467265, 4019.979900100481, 4076.7961601919787, 4187.20443115807, 4199.265128602482, 52751.208731869054, 52892.0, 53055.0, 53262.73368633132, 53497.1975420369, 47412.288815667795, 47711.52288477071, 47720.28419573709, 47805.0, 49318.26022609664, 41723.37414938778, 42088.158236835094, 43134.56865431306, 44675.32987005197, 44818.0, 8210.58947052633, 8387.66449342044, 8561.48631082137, 8616.138386161334, 8763.079876612865, 31070.378592427573, 31878.0, 31973.20066998344, 34350.31299374049, 34509.30981380409, 42298.15403691847, 42476.78761606296, 42580.574194257664, 42936.57063429326, 43038.78480607577, 10239.027292407209, 10452.581896724047, 10734.302270352402, 10937.671869843918, 11032.558697652004, 11305.321680699184, 11546.942265288955, 11567.595134170264, 11701.122415818678, 11853.34806585646, 9455.243580513405, 9875.407475551203, 9884.703458896245, 9955.950220248853, 9964.800703986024, 10789.838152427563, 10812.243142979916, 10849.511771970123, 10903.727406814576, 11217.326960382403, 10211.489425528842, 10419.791604168026, 10568.365898046142, 10798.406087665255, 10803.513841876977, 8739.91260087391, 8791.780205494913, 8891.244244239311, 9204.585793639437, 9317.767055823659, 8478.194571515696, 9388.765280868032, 9466.062809129231, 9558.0, 9642.057832497137], "unit": "score", "name": "yui.html", "value": 6012.488219300378}], "name": "dromaeo_css", "value": 6738.969212087334}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 110.0, 111.0, 123.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 151.0, 169.0, 124.0, 151.0, 148.0, 130.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 161.0, 163.0, 162.0, 162.0, 161.0, 164.0, 174.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 72.0, 73.0, 72.0, 72.0, 139.0, 74.0, 74.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 143.0, 97.0, 97.0, 97.0, 151.0, 97.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 112.0}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 63.0, 60.0, 61.0, 69.0, 60.0, 65.0, 60.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 94.0, 88.0, 86.0, 87.0, 87.0, 89.0, 89.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 123.0, 138.0, 121.0, 120.0, 128.0, 120.0, 126.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [147.0, 153.0, 162.0, 166.0, 150.0, 148.0, 157.0, 154.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 72.0, 68.0, 69.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1531.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [189.5734597156398], "unit": "score", "name": "DeltaBlue", "value": 348.77245000000016}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1092.896174863388], "unit": "score", "name": "RayTrace", "value": 677.089935}, {"lowerIsBetter": false, "replicates": [722.543352601156], "unit": "score", "name": "Earley", "value": 922.3847919999998}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [633.5012594458439], "unit": "score", "name": "Splay", "value": 128.6358926441352}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21153.48778836962}]} 11:17:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21153.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1531.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6738.97"}}} 11:17:35 INFO - Return code: 0 11:17:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:35 INFO - # TBPL SUCCESS # 11:17:35 INFO - Running post-action listener: _resource_record_post_action 11:17:35 INFO - Running post-run listener: _resource_record_post_run 11:17:36 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 567881728; Read time: 0; Write time: 487000 11:17:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247930880; Read time: 0; Write time: 251388 11:17:36 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 319950848; Read time: 0; Write time: 235612 11:17:36 INFO - Running post-run listener: _upload_blobber_files 11:17:36 INFO - Blob upload gear active. 11:17:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:17:36 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 11:17:36 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'] 11:17:36 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 11:17:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:38 INFO - (blobuploader) - INFO - Done attempting. 11:17:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:39 INFO - (blobuploader) - INFO - Done attempting. 11:17:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:39 INFO - Return code: 0 11:17:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:17:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ab86ee9316cd8c828c3d160d7a6806aa0213753c41ef8f63f954943f98240816096fa6a4e64d3eabf4408289a396fed4380847d7bf2135695c23a5789b12b52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a541e2c4f47561ba28a6f9cd226f84551776cac12a9c986b49fa5ea65210256df5b657879b73fdf9bcaa4abb28b5189583d8eae4861d6b91da1ea3869de98d2"} 11:17:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:17:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:17:39 INFO - Contents: 11:17:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1ab86ee9316cd8c828c3d160d7a6806aa0213753c41ef8f63f954943f98240816096fa6a4e64d3eabf4408289a396fed4380847d7bf2135695c23a5789b12b52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a541e2c4f47561ba28a6f9cd226f84551776cac12a9c986b49fa5ea65210256df5b657879b73fdf9bcaa4abb28b5189583d8eae4861d6b91da1ea3869de98d2"} 11:17:39 INFO - Copying logs to upload dir... 11:17:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.563991 ========= master_lag: 0.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-06 11:17:38.848552) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 11:17:38.852461) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 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/1ab86ee9316cd8c828c3d160d7a6806aa0213753c41ef8f63f954943f98240816096fa6a4e64d3eabf4408289a396fed4380847d7bf2135695c23a5789b12b52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a541e2c4f47561ba28a6f9cd226f84551776cac12a9c986b49fa5ea65210256df5b657879b73fdf9bcaa4abb28b5189583d8eae4861d6b91da1ea3869de98d2"} build_url:https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/aYseBTuZSWiPADMYuodw2A/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/1ab86ee9316cd8c828c3d160d7a6806aa0213753c41ef8f63f954943f98240816096fa6a4e64d3eabf4408289a396fed4380847d7bf2135695c23a5789b12b52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a541e2c4f47561ba28a6f9cd226f84551776cac12a9c986b49fa5ea65210256df5b657879b73fdf9bcaa4abb28b5189583d8eae4861d6b91da1ea3869de98d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 11:17:38.877077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 11:17:38.877393) ========= 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=3a3620fb28aea1604ab609ef000001d2-1452103998.6754-1947031790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 11:17:38.962041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 11:17:38.962356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 11:17:38.962667) ========= ========= Total master_lag: 1.09 =========