builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1452073529.04 results: success (0) buildid: 20160105233008 builduid: c268c98bf7b0462cba09d85f87d4b0cd revision: 027e623f8f26cc2e259eb548213c9c67ab9f08b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.035683) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.036178) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.036596) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006261 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.067428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.067809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.107217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.107491) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009472 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.173173) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.173662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.174372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.174876) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 01:45:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 151M=0s 2016-01-06 01:45:29 (151 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216937 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.437965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.438546) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063233 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.562352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:29.562990) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 027e623f8f26cc2e259eb548213c9c67ab9f08b5 --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 027e623f8f26cc2e259eb548213c9c67ab9f08b5 --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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 01:45:29,775 truncating revision to first 12 chars 2016-01-06 01:45:29,775 Setting DEBUG logging. 2016-01-06 01:45:29,775 attempt 1/10 2016-01-06 01:45:29,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/027e623f8f26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 01:45:30,018 unpacking tar archive at: fx-team-027e623f8f26/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514122 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:30.109327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:30.109635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:30.116876) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:30.117225) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 01:45:30.117691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-06 01:45:30.117983) ========= /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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:45:30 INFO - MultiFileLogger online at 20160106 01:45:30 in /builds/slave/test-pgo 01:45:30 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 01:45:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:45:30 INFO - {'append_to_log': False, 01:45:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:45:30 INFO - 'blob_upload_branch': 'Fx-Team', 01:45:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:45:30 INFO - 'branch': 'Fx-Team', 01:45:30 INFO - 'buildbot_json_path': 'buildprops.json', 01:45:30 INFO - 'config_files': ('talos/linux_config.py',), 01:45:30 INFO - 'default_actions': ('clobber', 01:45:30 INFO - 'read-buildbot-config', 01:45:30 INFO - 'download-and-extract', 01:45:30 INFO - 'populate-webroot', 01:45:30 INFO - 'create-virtualenv', 01:45:30 INFO - 'install', 01:45:30 INFO - 'run-tests'), 01:45:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:45:30 INFO - 'download_minidump_stackwalk': True, 01:45:30 INFO - 'download_symbols': 'ondemand', 01:45:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:45:30 INFO - 'tooltool.py': '/tools/tooltool.py', 01:45:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:45:30 INFO - '/tools/misc-python/virtualenv.py')}, 01:45:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:45:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:45:30 INFO - 'installer_path': 'installer.exe', 01:45:30 INFO - 'log_level': 'info', 01:45:30 INFO - 'log_name': 'talos', 01:45:30 INFO - 'log_to_console': True, 01:45:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:45:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:45:30 INFO - 'opt_config_files': (), 01:45:30 INFO - 'pip_index': False, 01:45:30 INFO - 'sps_profile': False, 01:45:30 INFO - 'sps_profile_interval': 0, 01:45:30 INFO - 'suite': 'dromaeojs-e10s', 01:45:30 INFO - 'system_bits': '32', 01:45:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:45:30 INFO - 'title': 'talos-linux64-ix-047', 01:45:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:45:30 INFO - 'use_talos_json': True, 01:45:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:45:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:45:30 INFO - 'work_dir': 'build'} 01:45:30 INFO - ##### 01:45:30 INFO - ##### Running clobber step. 01:45:30 INFO - ##### 01:45:30 INFO - Running pre-action listener: _resource_record_pre_action 01:45:30 INFO - Running main action method: clobber 01:45:30 INFO - rmtree: /builds/slave/test-pgo/build 01:45:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:45:35 INFO - Running post-action listener: _resource_record_post_action 01:45:35 INFO - ##### 01:45:35 INFO - ##### Running read-buildbot-config step. 01:45:35 INFO - ##### 01:45:35 INFO - Running pre-action listener: _resource_record_pre_action 01:45:35 INFO - Running main action method: read_buildbot_config 01:45:35 INFO - Using buildbot properties: 01:45:35 INFO - { 01:45:35 INFO - "project": "", 01:45:35 INFO - "product": "firefox", 01:45:35 INFO - "script_repo_revision": "production", 01:45:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:45:35 INFO - "repository": "", 01:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:45:35 INFO - "buildid": "20160105233008", 01:45:35 INFO - "pgo_build": "True", 01:45:35 INFO - "basedir": "/builds/slave/test-pgo", 01:45:35 INFO - "buildnumber": 182, 01:45:35 INFO - "slavename": "talos-linux64-ix-047", 01:45:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:45:35 INFO - "platform": "ubuntu64_hw", 01:45:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:45:35 INFO - "branch": "fx-team", 01:45:35 INFO - "repo_path": "integration/fx-team", 01:45:35 INFO - "revision": "027e623f8f26cc2e259eb548213c9c67ab9f08b5", 01:45:35 INFO - "stage_platform": "linux64-pgo", 01:45:35 INFO - "builduid": "c268c98bf7b0462cba09d85f87d4b0cd", 01:45:35 INFO - "slavebuilddir": "test" 01:45:35 INFO - } 01:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:45:35 INFO - Running post-action listener: _resource_record_post_action 01:45:35 INFO - ##### 01:45:35 INFO - ##### Running download-and-extract step. 01:45:35 INFO - ##### 01:45:35 INFO - Running pre-action listener: _resource_record_pre_action 01:45:35 INFO - Running main action method: download_and_extract 01:45:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:35 INFO - https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/test_packages.json 01:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/test_packages.json 01:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:45:37 INFO - Downloaded 1302 bytes. 01:45:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:45:37 INFO - Using the following test package requirements: 01:45:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:45:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'jsshell-linux-x86_64.zip'], 01:45:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:45:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:45:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:45:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:45:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:45:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:45:37 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')]} 01:45:37 INFO - https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:39 INFO - Downloaded 24054450 bytes. 01:45:39 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 01:45:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:39 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 01:45:40 INFO - Return code: 0 01:45:40 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 01:45: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')]} 01:45:40 INFO - https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:42 INFO - Downloaded 24054450 bytes. 01:45:42 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 01:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:45:42 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 01:45:43 INFO - Return code: 0 01:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:43 INFO - https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:44 INFO - Downloaded 11132285 bytes. 01:45:44 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 01:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:44 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 01:45:44 INFO - Return code: 0 01:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:44 INFO - https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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 01:45:45 INFO - Downloaded 55064130 bytes. 01:45:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:45 INFO - mkdir: /builds/slave/test-pgo/properties 01:45:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:45:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:45:45 INFO - Contents: 01:45:45 INFO - build_url:https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:45 INFO - Running post-action listener: _resource_record_post_action 01:45:45 INFO - Running post-action listener: set_extra_try_arguments 01:45:45 INFO - ##### 01:45:45 INFO - ##### Running populate-webroot step. 01:45:45 INFO - ##### 01:45:45 INFO - Running pre-action listener: _resource_record_pre_action 01:45:45 INFO - Running main action method: populate_webroot 01:45:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:45 INFO - '--tppagecycles', 01:45:45 INFO - '7'], 01:45:45 INFO - 'tests': ['tsvgm']}}, 01:45:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:45:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'tests': ['damp', 'tps']}, 01:45:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['damp', 'tps']}, 01:45:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:45:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:45 INFO - 'other': {'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'other_l64': {'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'other_nol64': {'tests': ['a11yr', 01:45:45 INFO - 'ts_paint', 01:45:45 INFO - 'tpaint', 01:45:45 INFO - 'sessionrestore', 01:45:45 INFO - 'sessionrestore_no_auto_restore']}, 01:45:45 INFO - 'svgr': {'tests': ['tsvgx', 01:45:45 INFO - 'tsvgr_opacity', 01:45:45 INFO - 'tart', 01:45:45 INFO - 'tscrollx', 01:45:45 INFO - 'cart']}, 01:45:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['tsvgx', 01:45:45 INFO - 'tsvgr_opacity', 01:45:45 INFO - 'tart', 01:45:45 INFO - 'tscrollx', 01:45:45 INFO - 'cart']}, 01:45:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'tests': ['tp5o']}, 01:45:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'talos_options': ['--e10s'], 01:45:45 INFO - 'tests': ['tp5o']}, 01:45:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'talos_options': ['--xperf_path', 01:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:45 INFO - 'tests': ['tp5n']}, 01:45:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:45 INFO - 'talos_options': ['--e10s', 01:45:45 INFO - '--xperf_path', 01:45:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:45 INFO - 'tests': ['tp5n']}}, 01:45:45 INFO - 'talos.zip': {'path': '', 01:45:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:45 INFO - Running post-action listener: _resource_record_post_action 01:45:45 INFO - ##### 01:45:45 INFO - ##### Running create-virtualenv step. 01:45:45 INFO - ##### 01:45:45 INFO - Running pre-action listener: _resource_record_pre_action 01:45:45 INFO - Running main action method: create_virtualenv 01:45:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:45: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 01:45:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:45:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:46 INFO - Using real prefix '/usr' 01:45:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:45:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:48 INFO - Installing pip.................done. 01:45:48 INFO - Return code: 0 01:45:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:48 INFO - Using env: {'DISPLAY': ':0', 01:45:48 INFO - 'HOME': '/home/cltbld', 01:45:48 INFO - 'LANG': 'en_US.UTF-8', 01:45:48 INFO - 'LANGUAGE': 'en_US:en', 01:45:48 INFO - 'LOGNAME': 'cltbld', 01:45:48 INFO - 'MAIL': '/var/mail/cltbld', 01:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:48 INFO - 'MOZ_NO_REMOTE': '1', 01:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:48 INFO - 'NO_EM_RESTART': '1', 01:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:48 INFO - 'SHELL': '/bin/bash', 01:45:48 INFO - 'SHLVL': '1', 01:45:48 INFO - 'TERM': 'linux', 01:45:48 INFO - 'TMOUT': '86400', 01:45:48 INFO - 'USER': 'cltbld', 01:45:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:48 INFO - '_': '/tools/buildbot/bin/python'} 01:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45: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 01:45:48 INFO - Cleaning up... 01:45:48 INFO - Return code: 0 01:45:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:48 INFO - Using env: {'DISPLAY': ':0', 01:45:48 INFO - 'HOME': '/home/cltbld', 01:45:48 INFO - 'LANG': 'en_US.UTF-8', 01:45:48 INFO - 'LANGUAGE': 'en_US:en', 01:45:48 INFO - 'LOGNAME': 'cltbld', 01:45:48 INFO - 'MAIL': '/var/mail/cltbld', 01:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:48 INFO - 'MOZ_NO_REMOTE': '1', 01:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:48 INFO - 'NO_EM_RESTART': '1', 01:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:48 INFO - 'SHELL': '/bin/bash', 01:45:48 INFO - 'SHLVL': '1', 01:45:48 INFO - 'TERM': 'linux', 01:45:48 INFO - 'TMOUT': '86400', 01:45:48 INFO - 'USER': 'cltbld', 01:45:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:48 INFO - '_': '/tools/buildbot/bin/python'} 01:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:48 INFO - Downloading/unpacking psutil>=0.7.1 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:45:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:45:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:50 INFO - Installing collected packages: psutil 01:45:50 INFO - Running setup.py install for psutil 01:45:50 INFO - building 'psutil._psutil_linux' extension 01:45: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 01:45: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:45:51 INFO - building 'psutil._psutil_posix' extension 01:45:51 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 01:45: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 01:45:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:51 INFO - Successfully installed psutil 01:45:51 INFO - Cleaning up... 01:45:51 INFO - Return code: 0 01:45:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:51 INFO - Using env: {'DISPLAY': ':0', 01:45:51 INFO - 'HOME': '/home/cltbld', 01:45:51 INFO - 'LANG': 'en_US.UTF-8', 01:45:51 INFO - 'LANGUAGE': 'en_US:en', 01:45:51 INFO - 'LOGNAME': 'cltbld', 01:45:51 INFO - 'MAIL': '/var/mail/cltbld', 01:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:51 INFO - 'MOZ_NO_REMOTE': '1', 01:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:51 INFO - 'NO_EM_RESTART': '1', 01:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:51 INFO - 'SHELL': '/bin/bash', 01:45:51 INFO - 'SHLVL': '1', 01:45:51 INFO - 'TERM': 'linux', 01:45:51 INFO - 'TMOUT': '86400', 01:45:51 INFO - 'USER': 'cltbld', 01:45:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:51 INFO - '_': '/tools/buildbot/bin/python'} 01:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:45:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:45:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45: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) 01:45:53 INFO - Installing collected packages: mozsystemmonitor 01:45:53 INFO - Running setup.py install for mozsystemmonitor 01:45:53 INFO - Successfully installed mozsystemmonitor 01:45:53 INFO - Cleaning up... 01:45:53 INFO - Return code: 0 01:45:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:53 INFO - Using env: {'DISPLAY': ':0', 01:45:53 INFO - 'HOME': '/home/cltbld', 01:45:53 INFO - 'LANG': 'en_US.UTF-8', 01:45:53 INFO - 'LANGUAGE': 'en_US:en', 01:45:53 INFO - 'LOGNAME': 'cltbld', 01:45:53 INFO - 'MAIL': '/var/mail/cltbld', 01:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:53 INFO - 'MOZ_NO_REMOTE': '1', 01:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:53 INFO - 'NO_EM_RESTART': '1', 01:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:53 INFO - 'SHELL': '/bin/bash', 01:45:53 INFO - 'SHLVL': '1', 01:45:53 INFO - 'TERM': 'linux', 01:45:53 INFO - 'TMOUT': '86400', 01:45:53 INFO - 'USER': 'cltbld', 01:45:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:53 INFO - '_': '/tools/buildbot/bin/python'} 01:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:53 INFO - Downloading/unpacking blobuploader==1.2.4 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:45:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45: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 01:45:55 INFO - Downloading docopt-0.6.1.tar.gz 01:45:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:56 INFO - Running setup.py install for blobuploader 01:45:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:45:56 INFO - Running setup.py install for requests 01:45:56 INFO - Running setup.py install for docopt 01:45:56 INFO - Successfully installed blobuploader requests docopt 01:45:56 INFO - Cleaning up... 01:45:56 INFO - Return code: 0 01:45:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:56 INFO - Using env: {'DISPLAY': ':0', 01:45:56 INFO - 'HOME': '/home/cltbld', 01:45:56 INFO - 'LANG': 'en_US.UTF-8', 01:45:56 INFO - 'LANGUAGE': 'en_US:en', 01:45:56 INFO - 'LOGNAME': 'cltbld', 01:45:56 INFO - 'MAIL': '/var/mail/cltbld', 01:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:56 INFO - 'MOZ_NO_REMOTE': '1', 01:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:56 INFO - 'NO_EM_RESTART': '1', 01:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:56 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:56 INFO - 'SHELL': '/bin/bash', 01:45:56 INFO - 'SHLVL': '1', 01:45:56 INFO - 'TERM': 'linux', 01:45:56 INFO - 'TMOUT': '86400', 01:45:56 INFO - 'USER': 'cltbld', 01:45:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:56 INFO - '_': '/tools/buildbot/bin/python'} 01:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:56 INFO - Running setup.py (path:/tmp/pip-YD8FUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:56 INFO - Running setup.py (path:/tmp/pip-BhmKA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:56 INFO - Running setup.py (path:/tmp/pip-v2DpwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:57 INFO - Running setup.py (path:/tmp/pip-QS4lrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:57 INFO - Running setup.py (path:/tmp/pip-cxy6Na-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:57 INFO - Running setup.py (path:/tmp/pip-G0joYd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:57 INFO - Running setup.py (path:/tmp/pip-8xSRUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:57 INFO - Running setup.py (path:/tmp/pip-BpMz5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:57 INFO - Running setup.py (path:/tmp/pip-yK3CBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:57 INFO - Running setup.py (path:/tmp/pip-h9ZFFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:57 INFO - Running setup.py (path:/tmp/pip-8lHSvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:57 INFO - Running setup.py (path:/tmp/pip-hNdLAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:57 INFO - Running setup.py (path:/tmp/pip-oTPewp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:57 INFO - Running setup.py (path:/tmp/pip-vdkx0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:57 INFO - Running setup.py (path:/tmp/pip-tYUZSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:57 INFO - Running setup.py (path:/tmp/pip-jhOszI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:58 INFO - Running setup.py (path:/tmp/pip-EedsJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:58 INFO - Running setup.py install for manifestparser 01:45:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Running setup.py install for mozcrash 01:45:58 INFO - Running setup.py install for mozdebug 01:45:58 INFO - Running setup.py install for mozdevice 01:45:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Running setup.py install for mozfile 01:45:58 INFO - Running setup.py install for mozhttpd 01:45:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Running setup.py install for mozinfo 01:45:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Running setup.py install for mozInstall 01:45:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Running setup.py install for mozleak 01:45:58 INFO - Running setup.py install for mozlog 01:45:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Running setup.py install for moznetwork 01:45:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Running setup.py install for mozprocess 01:45:59 INFO - Running setup.py install for mozprofile 01:45:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Running setup.py install for mozrunner 01:45:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Running setup.py install for mozscreenshot 01:45:59 INFO - Running setup.py install for moztest 01:45:59 INFO - Running setup.py install for mozversion 01:45:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:45:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:59 INFO - Cleaning up... 01:45:59 INFO - Return code: 0 01:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:45: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')]} 01:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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')]} 01:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:45: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 01:45: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 01:45:59 INFO - Using env: {'DISPLAY': ':0', 01:45:59 INFO - 'HOME': '/home/cltbld', 01:45:59 INFO - 'LANG': 'en_US.UTF-8', 01:45:59 INFO - 'LANGUAGE': 'en_US:en', 01:45:59 INFO - 'LOGNAME': 'cltbld', 01:45:59 INFO - 'MAIL': '/var/mail/cltbld', 01:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:59 INFO - 'MOZ_NO_REMOTE': '1', 01:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:59 INFO - 'NO_EM_RESTART': '1', 01:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:59 INFO - 'SHELL': '/bin/bash', 01:45:59 INFO - 'SHLVL': '1', 01:45:59 INFO - 'TERM': 'linux', 01:45:59 INFO - 'TMOUT': '86400', 01:45:59 INFO - 'USER': 'cltbld', 01:45:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:59 INFO - '_': '/tools/buildbot/bin/python'} 01:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46:00 INFO - Running setup.py (path:/tmp/pip-nnzErA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46:00 INFO - Running setup.py (path:/tmp/pip-QFkL1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46:00 INFO - Running setup.py (path:/tmp/pip-cQH8D1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46:00 INFO - Running setup.py (path:/tmp/pip-3TWI1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46:00 INFO - Running setup.py (path:/tmp/pip-7aKnad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46:00 INFO - Running setup.py (path:/tmp/pip-hMi4Yo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46:00 INFO - Running setup.py (path:/tmp/pip-JglydB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46:00 INFO - Running setup.py (path:/tmp/pip-nwgZrN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46:00 INFO - Running setup.py (path:/tmp/pip-FgFjDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46:00 INFO - Running setup.py (path:/tmp/pip-c21d96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46:00 INFO - Running setup.py (path:/tmp/pip-ShWat3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46:00 INFO - Running setup.py (path:/tmp/pip-cubp7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46:00 INFO - Running setup.py (path:/tmp/pip-69fGiJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:46: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)) 01:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46:01 INFO - Running setup.py (path:/tmp/pip-ioqHln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:46: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)) 01:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46:01 INFO - Running setup.py (path:/tmp/pip-FziIml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:46: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)) 01:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:46:01 INFO - Running setup.py (path:/tmp/pip-AHYOwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:46: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)) 01:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46:01 INFO - Running setup.py (path:/tmp/pip-FMvioq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:02 INFO - Downloading blessings-1.5.1.tar.gz 01:46: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 01:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:46:03 INFO - Installing collected packages: blessings 01:46:03 INFO - Running setup.py install for blessings 01:46:03 INFO - Successfully installed blessings 01:46:03 INFO - Cleaning up... 01:46:03 INFO - Return code: 0 01:46:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:46:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:46:03 INFO - Reading from file tmpfile_stdout 01:46:03 INFO - Current package versions: 01:46:03 INFO - argparse == 1.2.1 01:46:03 INFO - blessings == 1.5.1 01:46:03 INFO - blobuploader == 1.2.4 01:46:03 INFO - docopt == 0.6.1 01:46:03 INFO - manifestparser == 1.1 01:46:03 INFO - mozInstall == 1.12 01:46:03 INFO - mozcrash == 0.16 01:46:03 INFO - mozdebug == 0.1 01:46:03 INFO - mozdevice == 0.47 01:46:03 INFO - mozfile == 1.2 01:46:03 INFO - mozhttpd == 0.7 01:46:03 INFO - mozinfo == 0.9 01:46:03 INFO - mozleak == 0.1 01:46:03 INFO - mozlog == 3.1 01:46:03 INFO - moznetwork == 0.27 01:46:03 INFO - mozprocess == 0.22 01:46:03 INFO - mozprofile == 0.28 01:46:03 INFO - mozrunner == 6.11 01:46:03 INFO - mozscreenshot == 0.1 01:46:03 INFO - mozsystemmonitor == 0.0 01:46:03 INFO - moztest == 0.7 01:46:03 INFO - mozversion == 1.4 01:46:03 INFO - psutil == 3.1.1 01:46:03 INFO - requests == 1.2.3 01:46:03 INFO - wsgiref == 0.1.2 01:46:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:46: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')]} 01:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:46: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 01:46: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 01:46:03 INFO - Using env: {'DISPLAY': ':0', 01:46:03 INFO - 'HOME': '/home/cltbld', 01:46:03 INFO - 'LANG': 'en_US.UTF-8', 01:46:03 INFO - 'LANGUAGE': 'en_US:en', 01:46:03 INFO - 'LOGNAME': 'cltbld', 01:46:03 INFO - 'MAIL': '/var/mail/cltbld', 01:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:03 INFO - 'MOZ_NO_REMOTE': '1', 01:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:03 INFO - 'NO_EM_RESTART': '1', 01:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:03 INFO - 'SHELL': '/bin/bash', 01:46:03 INFO - 'SHLVL': '1', 01:46:03 INFO - 'TERM': 'linux', 01:46:03 INFO - 'TMOUT': '86400', 01:46:03 INFO - 'USER': 'cltbld', 01:46:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:03 INFO - '_': '/tools/buildbot/bin/python'} 01:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46: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)) 01:46:03 INFO - Cleaning up... 01:46:03 INFO - Return code: 0 01:46:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:46: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')]} 01:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:46: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 01:46: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 01:46:03 INFO - Using env: {'DISPLAY': ':0', 01:46:03 INFO - 'HOME': '/home/cltbld', 01:46:03 INFO - 'LANG': 'en_US.UTF-8', 01:46:03 INFO - 'LANGUAGE': 'en_US:en', 01:46:03 INFO - 'LOGNAME': 'cltbld', 01:46:03 INFO - 'MAIL': '/var/mail/cltbld', 01:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:03 INFO - 'MOZ_NO_REMOTE': '1', 01:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:03 INFO - 'NO_EM_RESTART': '1', 01:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:03 INFO - 'SHELL': '/bin/bash', 01:46:03 INFO - 'SHLVL': '1', 01:46:03 INFO - 'TERM': 'linux', 01:46:03 INFO - 'TMOUT': '86400', 01:46:03 INFO - 'USER': 'cltbld', 01:46:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:03 INFO - '_': '/tools/buildbot/bin/python'} 01:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:03 INFO - Downloading/unpacking jsonschema 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46: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 01:46:05 INFO - Downloading/unpacking functools32 (from jsonschema) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:05 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46: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 01:46:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:05 INFO - warning: no files found matching '*.txt' 01:46:05 INFO - no previously-included directories found matching 'build' 01:46:05 INFO - no previously-included directories found matching 'dist' 01:46:05 INFO - no previously-included directories found matching '.git*' 01:46:05 INFO - Installing collected packages: jsonschema, functools32 01:46:05 INFO - Running setup.py install for functools32 01:46:05 INFO - warning: no files found matching '*.txt' 01:46:05 INFO - no previously-included directories found matching 'build' 01:46:05 INFO - no previously-included directories found matching 'dist' 01:46:05 INFO - no previously-included directories found matching '.git*' 01:46:05 INFO - Successfully installed jsonschema functools32 01:46:05 INFO - Cleaning up... 01:46:06 INFO - Return code: 0 01:46:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:46: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')]} 01:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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 0x7fecdb195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, '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': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', '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 01:46: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 01:46: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 01:46:06 INFO - Using env: {'DISPLAY': ':0', 01:46:06 INFO - 'HOME': '/home/cltbld', 01:46:06 INFO - 'LANG': 'en_US.UTF-8', 01:46:06 INFO - 'LANGUAGE': 'en_US:en', 01:46:06 INFO - 'LOGNAME': 'cltbld', 01:46:06 INFO - 'MAIL': '/var/mail/cltbld', 01:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:06 INFO - 'MOZ_NO_REMOTE': '1', 01:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:06 INFO - 'NO_EM_RESTART': '1', 01:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:06 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:06 INFO - 'SHELL': '/bin/bash', 01:46:06 INFO - 'SHLVL': '1', 01:46:06 INFO - 'TERM': 'linux', 01:46:06 INFO - 'TMOUT': '86400', 01:46:06 INFO - 'USER': 'cltbld', 01:46:06 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:06 INFO - '_': '/tools/buildbot/bin/python'} 01:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:06 INFO - Downloading/unpacking flake8 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:46: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 01:46:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:46: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 01:46:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:46:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:08 INFO - no previously-included directories found matching 'docs/_build' 01:46:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:46:08 INFO - Running setup.py install for pep8 01:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:08 INFO - no previously-included directories found matching 'docs/_build' 01:46:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:46:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:46:08 INFO - Cleaning up... 01:46:08 INFO - Return code: 0 01:46:08 INFO - Running post-action listener: _resource_record_post_action 01:46:08 INFO - Running post-action listener: _start_resource_monitoring 01:46:08 INFO - Starting resource monitoring. 01:46:08 INFO - ##### 01:46:08 INFO - ##### Running install step. 01:46:08 INFO - ##### 01:46:08 INFO - Running pre-action listener: _resource_record_pre_action 01:46:08 INFO - Running main action method: install 01:46:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:46:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:46:09 INFO - Reading from file tmpfile_stdout 01:46:09 INFO - Detecting whether we're running mozinstall >=1.0... 01:46:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:46:09 INFO - Reading from file tmpfile_stdout 01:46:09 INFO - Output received: 01:46:09 INFO - Usage: mozinstall [options] installer 01:46:09 INFO - Options: 01:46:09 INFO - -h, --help show this help message and exit 01:46:09 INFO - -d DEST, --destination=DEST 01:46:09 INFO - Directory to install application into. [default: 01:46:09 INFO - "/builds/slave/test-pgo"] 01:46:09 INFO - --app=APP Application being installed. [default: firefox] 01:46:09 INFO - mkdir: /builds/slave/test-pgo/build/application 01:46: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'] 01:46: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 01:46:25 INFO - Reading from file tmpfile_stdout 01:46:25 INFO - Output received: 01:46:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:46:25 INFO - Running post-action listener: _resource_record_post_action 01:46:25 INFO - ##### 01:46:25 INFO - ##### Running run-tests step. 01:46:25 INFO - ##### 01:46:25 INFO - Running pre-action listener: _resource_record_pre_action 01:46:25 INFO - Running main action method: run_tests 01:46:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:46:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:46:25 INFO - Python 2.7.3 01:46:25 INFO - Return code: 0 01:46:25 INFO - grabbing minidump binary from tooltool 01:46: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')]} 01:46: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 0x1781740>, '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 0x1782640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1782af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:46: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 01:46: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 01:46:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:46:25 INFO - Return code: 0 01:46:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:46:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:46:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:46:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:46:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:46:26 INFO - Return code: 0 01:46: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/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 01:46: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/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 01:46:26 INFO - Using env: {'DISPLAY': ':0', 01:46:26 INFO - 'HOME': '/home/cltbld', 01:46:26 INFO - 'LANG': 'en_US.UTF-8', 01:46:26 INFO - 'LANGUAGE': 'en_US:en', 01:46:26 INFO - 'LOGNAME': 'cltbld', 01:46:26 INFO - 'MAIL': '/var/mail/cltbld', 01:46:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:26 INFO - 'MOZ_NO_REMOTE': '1', 01:46:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:26 INFO - 'NO_EM_RESTART': '1', 01:46:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:26 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:46:26 INFO - 'SHELL': '/bin/bash', 01:46:26 INFO - 'SHLVL': '1', 01:46:26 INFO - 'TERM': 'linux', 01:46:26 INFO - 'TMOUT': '86400', 01:46:26 INFO - 'USER': 'cltbld', 01:46:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937', 01:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:26 INFO - '_': '/tools/buildbot/bin/python'} 01:46: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/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 01:46:26 INFO - mozversion application_buildid: 20160105233008 01:46:26 INFO - mozversion application_changeset: 027e623f8f26cc2e259eb548213c9c67ab9f08b5 01:46:26 INFO - mozversion application_display_name: Nightly 01:46:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:46:26 INFO - mozversion application_name: Firefox 01:46:26 INFO - mozversion application_remotingname: firefox 01:46:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:46:26 INFO - mozversion application_vendor: Mozilla 01:46:26 INFO - mozversion application_version: 46.0a1 01:46:26 INFO - mozversion platform_buildid: 20160105233008 01:46:26 INFO - mozversion platform_changeset: 027e623f8f26cc2e259eb548213c9c67ab9f08b5 01:46:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:46:26 INFO - mozversion platform_version: 46.0a1 01:46:26 INFO - using testdate: 1452073586 01:46:26 INFO - actual date: 1452073586 01:46:26 INFO - starting webserver on 'localhost:55473' 01:46:26 INFO - SUITE-START | Running 3 tests 01:46:26 INFO - TEST-START | dromaeo_css 01:46:26 INFO - operating with platform_type : linux_ 01:46:26 INFO - Initialising browser for dromaeo_css test... 01:46:26 INFO - TEST-INFO | started process 20362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGNRYVC/profile http://localhost:55473/getInfo.html) 01:46:30 INFO - PROCESS | 20362 | __metrics Screen width/height:1600/1200 01:46:30 INFO - PROCESS | 20362 | colorDepth:24 01:46:30 INFO - PROCESS | 20362 | Browser inner width/height: 1024/697 01:46:30 INFO - PROCESS | 20362 | __metrics 01:46:30 INFO - PROCESS | 20362 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:46:31 INFO - TEST-INFO | 20362: exit 0 01:46:31 INFO - Browser initialized. 01:46:31 INFO - Running cycle 1/1 for dromaeo_css test... 01:46:31 INFO - TEST-INFO | started process 20493 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGNRYVC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:43 INFO - PROCESS | 20493 | RSS: Main: 150720512 01:46:43 INFO - PROCESS | 20493 | 01:47:33 INFO - PROCESS | 20493 | 1452073653186 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] 01:49:42 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55473/tests/dromaeo/cssquery-ext.html) 01:49:43 INFO - PROCESS | 20493 | RSS: Main: 158654464 01:49:43 INFO - PROCESS | 20493 | 01:52:45 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-ext.html (next: http://localhost:55473/tests/dromaeo/cssquery-jquery.html) 01:52:45 INFO - PROCESS | 20493 | RSS: Main: 154054656 01:52:45 INFO - PROCESS | 20493 | 01:55:47 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55473/tests/dromaeo/cssquery-mootools.html) 01:55:48 INFO - PROCESS | 20493 | RSS: Main: 152838144 01:55:48 INFO - PROCESS | 20493 | 01:58:49 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55473/tests/dromaeo/cssquery-prototype.html) 01:58:50 INFO - PROCESS | 20493 | RSS: Main: 152199168 01:58:50 INFO - PROCESS | 20493 | 02:01:52 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55473/tests/dromaeo/cssquery-yui.html) 02:01:53 INFO - PROCESS | 20493 | RSS: Main: 152326144 02:01:53 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | Cycle 1(1): loaded http://localhost:55473/tests/dromaeo/cssquery-yui.html (next: http://localhost:55473/tests/dromaeo/cssquery-dojo.html) 02:04:56 INFO - PROCESS | 20493 | RSS: Main: 154800128 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | __start_tp_report 02:04:56 INFO - PROCESS | 20493 | _x_x_mozilla_page_load 02:04:56 INFO - PROCESS | 20493 | _x_x_mozilla_page_load_details 02:04:56 INFO - PROCESS | 20493 | |i|pagename|runs| 02:04:56 INFO - PROCESS | 20493 | |0;dojo.html;3101.643311019233;3165.5093460513626;3194.361127774446;3195.5224774028775;3217.2600301930556;5145.794168233266;5308.761105750241;5314.335708036496;5321.840344789653;5341;5225.216217567367;5284.365876094865;5318.494742999418;5343.545798607113;5473.17902314653;4792.089502994438;4794.472608013116;4795.520447955194;4834.830780922668;4946.332245146913;4896.755162241873;4900.901981960359;4910.067087253428;4922.360093187881;4930.80276788928;4710.74090924999;4792.400949881265;4820.493848145947;4917.36074310341;4942.036302920932;4875.731834749087;4890.755462226874;4891.144049791308;4903.509649035103;4939.827106051271;4706.058788242365;4861.975690121527;4873.926891096637;4884.169691152512;4915.16442204826;5121.8463446096675;5154.510321519487;5160.690358578498;5180.378354597435;5197.506236907526;5737.684427356494;5759.827205183851;5760.0783874579865;5762.971185144047;5771.740271687784;5680.4319568042865;5794.246747922785;5803.82588522345;5820.068788993741;5822.650640961556;5285.920711189336;5321.574274058066;5322.33470816148;5333.386660534049;5353.330833645794;5842.795502157404;5856.355800861902;5879.294484661782;5881.264841894763;5899.734511946973;5599.468050535193;5642.26650535436;5649.350324712628;5652.6325788824415;5691.544676425959;5677.517411020027;5683.914741278884;5685.800996965087;5688.288963879515;5737.483626473554;5608.49523542875;5651.943480565142;5652.802151924663;5659.292588426447;5664.915026274609;5538.6399884007415;5629.071203251499;5666.433356664301;5669.461401166883;5678.886422271614;4377.4965878923695;4432.13573353193;4438.112377524508;4449.28811390176;4475.060237350128;3972.463717398172;3986.421968814506;3987.9202415951518;3994.121293315466;4018.176273863851;5329.387120481117;5385.353757549119;5428.430014848463;5428.864278393072;5449.237106805051;5695.971520142372;5770.855728606734;5783.277090363705;5821.88356232873;5822.272215973004;5376.327959005124;5385.515303622693;5389.191621256843;5390.407055223922;5394.487523685244;4904.215325547966;4935.259711043373;4936.481669424658;4952.851414457572;4954.157793175169;5767.452092051249;5819.854503637443;5822.446867547576;5887.4406931341455;5954.76180952757;5800.854978625568;5809.8547536311935;5827.79602713903;5827.8834423310445;5838.357780644211;5775.884482310246;5885.087811389241;5993.9700301498215;6042.848928776816;6064.848378790565;5594.580406469449;5628.549716022627;5675.489205971482;5678.716064196857;5720.141978703228;5738.770449182153;5776.480116789509;5779.190913272229;5784.94215057844;5810.331811841692;5555.50000499957;5617.241672374341;5642.746076426489;5648.237487939075;5687.544996400361;5625.296837895263;5698.430156984268;5717.42825717425;5721.170430287668;5728.054870946414;5581.358143813351;5600.0759874620235;5627.634203776742;5635.267415235993;5641.435856414326;5443.129099344086;5546.722663866871;5580.190872323409;5669.092945128759;5679.630823996427;5436.668016335865;5448.591355648263;5461.371942226536;5471.452854714656;5502.724863756716 02:04:56 INFO - PROCESS | 20493 | |1;ext.html;524.6013030097125;555.469526602095;597.3817099302223;605.261580871337;606.790657223258;34822;35652.2869542609;35653.64346356536;35805.2838943221;35830.46254306184;37999.62000379995;38384.80807595965;38410.61589384105;38445.807770961175;38501.22997540048;8463.365247606424;8577.699780507683;8610.56947152643;8624.611892464824;8637.697680581181;8402.663893444254;8460.66157353705;8520.914790852104;8696.39125261232;8721.433106848066;8670.956645216766;8738.432001919886;8786;8788.03331633523;8814.603342849556;8593.742187734379;8688.044315125331;8711.869321960145;8712.0416754157;8741.169588889108;8518.23335899772;8655;8665.39342246043;8694.521801300925;8700.521471319074;38827;38895.41656875149;38968.610313897065;39252.60747392547;39280.21439571221;3059.6787337329483;3221.629512606057;3317.7511686623598;3500.6149323574386;3627.220147668264;29213.561796573067;29239.56140657892;29698.85150574255;30048.248793780112;30587;3736.57029441615;3753.3619284721663;3764.642358975893;3814.16088460541;3816.7709937403843;196046;196734;196744;196967;197041;50233;51455;52338;59369.40630593725;60587;52454.47545524572;52485;52502.47497525052;52596;52672.473275266755;15244.390224391122;15371.769423458658;15491.380344786308;15513.767293490606;15515.224238788016;11149.832752508719;11172.608958686407;11190.66428007161;11191.216614837045;11291.153163512769;19376.93426861536;19475.318363857197;19497;19515.316963906196;19523.609527809363;7694.115176754744;7886.250806173404;7992.920070799334;8088.797780055545;8094.676212951534;872.4372779557277;896.8699538566872;914.8170365926841;919.4850883505259;946.5456580841235;25424.491510169693;25618.23145305644;25626.74373256281;29114.708852911623;29820.85089574538;953.8998405167357;980.3284749946309;983.1643103362085;987.0672214756986;1050.1965996013057;13664.590062298146;15565.533034008999;15781.526554203392;15791.763123553155;16075.115868627105;235318;237316;237390;237416;238763;47436;47801.521984780404;47801.521984780404;47828.7608561955;47829.521704782506;1274.7004453953314;1288.2850018239967;1291.9135596012372;1312.4290933443983;1319.7822359310799;27903.302417439725;29108.272293191993;29166;29249.85375073196;29557.556636650897;43612;44004.559954401324;44080.559194408925;44237.778811107026;44358;274920;276828;276883;276917;277375;27476.17571472859;27809.58285625677;29749.958751443595;31052.534211986385;31578.210544736565;36109.81945090258;37541.624583753815;39147;39165.216695666495;40348.596514034485;33354.4996825043;33493.16267093342;33520.83239583884;33689;34306.65693343035;34654.653453465144;34654.653453465144;34745.30509389849;35459.82270088633;36721.26557468889;31904.68095319017;32527.837360813046;32630.184245394055;32796.18009549685;32867.178320542174;30093.69906300909;31485.685143149192;31516.212094697818;32146;32254.19364515812;24431.26706198817;24562.50874982526;25008.249752507454;25185.74814251834;25384.619230711924 02:04:56 INFO - PROCESS | 20493 | |2;jquery.html;355.3000588839984;355.35325707212866;359.68527538403896;359.88843458527856;365.7750483452676;16213.270402831871;16823.83176168238;17397.782155249108;17651.382201622946;18037.27850885963;11023.118150547956;11776.646700598996;16262.918685406587;16270.43053493128;16400.09799461032;4851.175300198957;5066.088104141253;5083.745812709368;5085.364329458817;5089.033083714083;5027.673201241926;5082.110630639641;5086;5087.465816089313;5093.057784309896;5030.974845125769;5065.265536497206;5079.060373830835;5203.245529398235;5206.375234971809;5077.543021128079;5079.6190285728535;5084.491550844923;5117.590592752608;5119.1809310510325;5174.534291913746;5231.163013917793;5240.423553409122;5249.737513124329;5270.183121616155;12532.561360352343;12751.42618582166;19008.90495547527;20291.188352465884;20791;1890.6124244529838;1909.0550177662008;1992.9701054484194;2033.1155947163031;2082.4897900014444;9370.67202647904;9383.06169383063;9479.052094790535;9547.379420337656;9775.071368220008;1765.8675599330102;1847.7413162157309;1850.777906651197;1851.2317388283846;1853.2586965213889;52655;55788.442115579135;55795.72102139463;55891.72054139703;56063.15905261384;10121.392716437038;10125.088742013255;10131.544080516247;10136.138428233535;10181.440020798778;12993.285369304589;13042.217466952014;13142.34288285601;13160.670983225496;13645.863541364657;7643.7324693635455;7731.7680469586;7748.108967468813;7867.252611001945;7907.655698531264;7393.704251829867;7414.518056326321;7437.479376443597;7481.289277518627;7507.873818927204;4448.955510444919;4530.478994915561;4533.297338912474;4544.977275113603;4556.088782243498;1834.3488061737892;1840.6226723521645;1852.5646473078816;1880.1915176473974;1888.5845114074882;418.2429802058284;433.3586292287432;439.4484921423657;455.27838376174134;464.35918432562846;10961.83557246642;11242.775144497227;11392.715182120513;11599.304041757352;11618.302901825917;440.6716995838121;452.093552427381;461.8498987828969;465.3206318774559;473.995260047402;6045.8488537786025;6154.630722156685;6204.658743769046;6271.655058971709;6310.747570097236;519828;520621;520951;550823;550855;46419.82221600072;80374.598127009;81255;81396;84024.15975840163;487.74393443441767;491.29008582597805;491.30235066206075;491.75903807134245;492.7856382473635;10154.238432117472;10270.229732770222;10472.476376181314;10616;14874.925625371803;19093.23627054958;31392.843035784674;32241.677583224806;33138.50292245667;33768.50477889178;42351.57648423476;47419.76290118528;49370.01259974852;49780.75109624429;49940.250896235855;9672.854907176257;9797.412155270707;9849.507524623883;9901.15840153595;9909.65316213929;11922.165448418527;12063.75872482563;12101.515939362678;12121.333326667118;12144.817827732768;12027.398630068286;14981.726553243096;15028.474003409829;15056.774148388002;15122.697546048797;12358.938205308916;14504.709905801614;14751.188684622448;14964.625884352978;15167.848321516643;14986.550403487912;15045.247737613294;15198.164100974553;15198.392064317304;15594.220288985733;9741;9793.559289832117;9828.655997040069;9911.950440247752;10001.74995625086;11703.531858725897;15039.699206016037;15052.247387630356;15079.095254284777;15209.543713688165 02:04:56 INFO - PROCESS | 20493 | |3;mootools.html;1445.71808497343;1448.8261408630965;1599.9120048397333;1757.1126581076555;1796.0929730486112;6962.268961759006;7074.398676112537;7606.543607383561;7737.342325902291;7758.689652413904;7220;7297.379722723562;7324.633768311576;7377.889331660016;7390.113186417624;2296.4832912594657;2311.167979527369;2333.0667732906804;2338.4387746940697;2343.297010896733;2250.144944920936;2281.7147856517936;2283.8058765004994;2284.326123793485;2292.071710957065;2235.2958817972367;2253.43664083979;2280.794728474437;2291.472961218921;2300.769923007703;2251.425886398974;2304.6888670029584;2318.802901753353;2320.512692334612;2325.5116425550655;2312.9306120816404;2331.8717470539113;2339.239747082205;2342.26218741096;2349.7532759060223;7698.807529811799;7758.952541406894;7765.456418050739;7790.649420776079;7817.804554886116;4579.4504659440745;4591.196540605414;4596.103759766846;4648.209804333238;4650.953490465085;2965.851707414642;3040.9695903040906;3074.123874695701;3075.2926826829953;3107.6115485564305;986.1322036607739;991.8561808537794;1748.8251174882537;1770.3184274054454;1787.4101546489628;10736.892631073668;10814.188935829765;10899.12806975448;10900.1279897608;10920.2901811382;4169.833206671699;4191.8532851350055;4229.534751177368;4263.957360426418;4272.743635381887;8693.695720649874;8827.514486703165;8830.690925817566;8840.115988401109;8867.73396798097;4645.558671926162;4649.256119020941;4652.883677908079;4657.673962822638;4658.138244424792;4236.216299984451;4305.827766889352;4331.978340108342;4337.392765012901;4338.219120558329;3509.2279698466295;3509.350770107538;3510.157562185057;3534.699550538233;3556.1287484566446;1027.2398425165325;1031.6131450705984;1035.316690983947;1057.9682609521574;1058.439027315524;1310.0567591334225;1321.5837011341396;1332.2206509192038;1364.3382959264748;1365.1808914651328;7134.892976605355;7226.783196504113;7392.112946446461;7399.667014984231;7421.369183619345;469.1180580508622;472.46375363961465;505.39605171820057;506.5263978180413;507.8755704852335;5714.399988001283;5742.827715168552;5754.079347304411;5766.163906233573;5804.738786754606;8807.779805504786;9333.766655833659;9384.718458446258;9408.670696525589;9538.23694104484;9217.493037882847;9282.257419406431;9325.487098209527;9375.10936461035;9385.67150149755;6938.757143499954;7060.117485314336;7083.539569927938;7119.4660400470175;7306.525075870158;7195.784126476214;7216.134063912364;7225.5664660120565;7230.819229519304;7261.5280006799385;7888.092869320101;8011.078725946591;8184.2224988625985;8203.384746143944;8293.377996650155;8403.075661677089;8410.411271211202;8424.831503369776;8440.324774017941;8468.449550779425;6428.839279017875;6519.706613202512;6566.376194261537;6576.572522786004;6809.182898052265;6889.552179108542;6953.930460695328;6960.095187625576;6980.371766541036;7006.159260888726;6571.211454625475;6971.233164352018;6996.300369963166;7022.227554969051;7119.501634885508;6612.23959244693;6651.567648102858;6670.199576050711;6777.593344399352;7018.157821061505;6649.03588979605;6699.430548403246;6716.697748601422;6743.865122697421;6752.763653272112;6068.423499767515;6076.635401875901;6109.75560977556;6115.724792384264;6126.938730612816;6104.145419641165;6120.234970628671;6128.387161283836;6159.23009623797;6162.938370616236 02:04:56 INFO - PROCESS | 20493 | |4;prototype.html;339.79951828421235;347.3296537682274;348.07270852133564;348.2390975718055;350.21027582800787;6132.325444201134;6151.723172457233;6161.507079433646;6236.251649802019;6296.401841825019;6139.079138129283;6189.907151392721;6205.596636218643;6207.286162091361;6208.099825525296;4688.367070445481;4698.483166851644;4700.106979673868;4706.317583950326;4709.0346478971815;4666.160091183586;4692.4369075710965;4708;4717.834875779348;4722.97638511807;4471.8658440246845;4528.547145285478;4605.861824145281;4639.327297541854;4653.953460465385;4589.885252868671;4602.562756538157;4608;4616.722996620197;4631.4673812511655;3958.0698535844053;3970.5433875104445;3978.8209530571194;4017.678585713136;4030.1536677297804;5818.5054270386645;5875.236219291507;5876.647401155901;5878.970605146947;5879.588428809985;5282.577393808486;5436.728163591844;5451.972740136313;5461.972690136564;5485.862853428656;6493.610383376965;6504.674766261668;6574.2110946686225;6575.342465753434;6577.342265773432;4467.128909862578;4514.548545145492;4519.796609152596;4520.163769702615;4525;6742.898856517205;6747.831304217385;6803.863922721518;6819.556728812611;6886.035954966309;4609.884752881205;4610.838620648261;4661.067786442725;4664.277037059262;4673.60274376675;4660.883477913079;4675.392199014106;4694.342792009122;4694.342792009122;4698.577128058491;5440.591955603346;5447.782088716486;5454.890902182014;5464.480874316933;5465.81367453014;6452.09595783125;6618.172728408949;6619.5035372347265;6629.204495460575;6629.370209830058;1626.0975158786987;1631.037687764201;1636.3454618152834;1638.7787648667277;1638.942637007699;1106.568438309044;1112.4326593437406;1114.7603265298;1114.8662160540787;1130.423484023154;6322.747090116436;6328.398802113792;6332.561963644031;6340.714667839959;6342.682865856688;6744.83137921546;6802.693878775467;6813.454923606099;6819.897701534481;6821.147356580427;6076.939230607726;6252.531060170414;6256.5307601930035;6310.7791227306825;6320.083587879732;3638.872639457606;3682.6869716073898;3688.1927855351223;3702.555693316819;3747.100695833035;7164.785056448315;7195.96402017997;7202.675879585431;7204.639768011579;7210.927890721131;6809.693563789641;6973.058637083929;6980.057692211486;6992.755253566101;7005.754798582026;7143.357097861322;7147.785566433015;7218;7221;7226.855462890818;6780.593164410151;6781.7287308509085;6784.864302714017;6791.558548694319;6812.727490900308;6542.934570654233;6698.66506674674;6720.361565651256;6763.932360676527;6817.386435220854;7175.820604484721;7203.963980180066;7217.097862767154;7218.242084581043;7219.278072192738;4737.668363214542;4786.138495070921;4786.521347865186;4789.401324834395;4793.784279707352;6621.6689165540565;6754.831129221809;6759.357861003196;6776;6791.864162716619;6519.315471875574;6546.0508226307875;6548.901766473411;6611.471082313307;6614.173228346457;6485.44873685742;6559.409653131241;6569.277379488348;6577.046328282277;6578.013298005338;6304.590201636879;6447.355264473703;6452.257990330984;6458.354164583504;6470.932296171079;6609.900851487328;6611.371919667624;6612.669366531751;6624.635645039569;6625.536212465274;6320.715567799552;6405.967970160119;6419.550631455753;6434.420902118832;6435.549511534147 02:04:56 INFO - PROCESS | 20493 | |5;yui.html;641.1664835713572;649.9015225555515;664.3323459922777;674.3054653706682;698.6227437183921;11867.70330741732;12047.51809927604;12054.21647592907;12292.078094142942;12360.814587781191;12695.11134220605;12818.974482041438;12942.935285323583;13000.41498132584;13044.413001414936;804.9034115906085;805.5529181304373;816.0696805641574;817.2032268538187;818.4189225649795;792.4888446951712;799.0251892690936;799.7081065411112;802.7671975127236;804.5775967616989;845.5560830563973;845.9577021148949;849.1847826086934;849.8470275350435;850.26452118917;847.4364547575855;848.9915100849005;849.1678155407674;851.3614788908319;853.4239388412858;611.5871786544064;628.0767272109991;628.6730899932055;631.6368088349218;633.5660072850067;11964.1625086244;12031.51873925042;12047.277163370138;12141.696457588543;12240;11195.440227988567;11335.37655428951;11698.532058717641;11813.29120252779;12658.113932024762;8963.55182240892;9135.177833994905;9186.356955013152;9645.421274723469;9769.267304952156;3466.098814308298;3483.2511010132944;3500.114643458841;3500.597431295408;3516.718662507019;48443;48852.51147488515;48904.26643600349;49005.75497122527;49039;9791.853122203172;9867;9972.152367048737;10003.2997690161;10129.290949633454;17467.47597572075;17618.91190544039;17669.381571645186;17679.73480397795;17690.203940822696;7148.571085734872;7176.282371762886;7189.460790440738;7311.0495635568095;7331.963340183265;4113.547509773923;4134.193832202692;4158.4178215049915;4163.562825903297;4174.77038762871;3034.180771191766;3037.3166037641795;3048.420800047984;3048.9390212196076;3061.265296328865;553.582045555611;559.7844829740498;574.8419184724235;577.9508741756914;580.94771470567;469.3921371823497;505.4970304546926;530.4536327582596;575.2952633024595;642.1363266406676;7780.727674531364;7830.686772529149;7861.331786798072;8003.079645840687;8110.107888132301;552.3068548971096;589.4842013238416;609.4606273447941;622.5673157155733;626.3079297376424;3695.9630403696156;3705.0366904605;4012.518497780227;4058.3912413137673;4284.121755040209;52508.73745631324;55071.449285507435;55212.72393638006;55283.170752438746;55307.170392444146;48484.757576211894;48711.512884870695;49591.75204123956;49811.75094124506;50694;43616.47342343003;43807;43829;44281.33577996332;44312.77843610761;7874.094479134973;7896.62027833002;7926.405519586169;8082.959585202037;8259.9587002067;32803.507947380334;33019.504707429885;33107;33666.83166584151;33698.326033478705;41124.79437602793;41870.37194442025;41903.371449428894;42008.57991420169;42864.57135428606;10519.684409467729;10746.623868164577;11011.559537618727;11181.440927953407;11295.943520282346;10195.949020254851;10297;10872;10942.726431839268;11076.224664273423;10358.223133265186;10363.119134873621;10373.170146388422;10461.110805581611;10499;10111.797764044824;10261.74345641365;10511.054005139575;10786.137109031415;10820.621278255223;9642.662506812228;9801.558929848317;10132.696019119438;10268.948655256676;10676.62631807883;9072;9122.589483473392;9597.808043839224;9663.7987561348;9949.602015919281;8991.595378207865;9089.181973622406;9104.362694611578;9122.90877091247;9227.123423274777 02:04:56 INFO - PROCESS | 20493 | __end_tp_report 02:04:56 INFO - PROCESS | 20493 | __start_cc_report 02:04:56 INFO - PROCESS | 20493 | _x_x_mozilla_cycle_collect,307 02:04:56 INFO - PROCESS | 20493 | __end_cc_report 02:04:56 INFO - PROCESS | 20493 | __startTimestamp1452074696324__endTimestamp 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | ------- Summary: start ------- 02:04:56 INFO - PROCESS | 20493 | Number of tests: 6 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#0] dojo.html Cycles:165 Average:5322.25 Median:5546.72 stddev:592.08 (10.7%) stddev-sans-first:567.69 02:04:56 INFO - PROCESS | 20493 | Values: 3101.6 3165.5 3194.4 3195.5 3217.3 5145.8 5308.8 5314.3 5321.8 5341.0 5225.2 5284.4 5318.5 5343.5 5473.2 4792.1 4794.5 4795.5 4834.8 4946.3 4896.8 4900.9 4910.1 4922.4 4930.8 4710.7 4792.4 4820.5 4917.4 4942.0 4875.7 4890.8 4891.1 4903.5 4939.8 4706.1 4862.0 4873.9 4884.2 4915.2 5121.8 5154.5 5160.7 5180.4 5197.5 5737.7 5759.8 5760.1 5763.0 5771.7 5680.4 5794.2 5803.8 5820.1 5822.7 5285.9 5321.6 5322.3 5333.4 5353.3 5842.8 5856.4 5879.3 5881.3 5899.7 5599.5 5642.3 5649.4 5652.6 5691.5 5677.5 5683.9 5685.8 5688.3 5737.5 5608.5 5651.9 5652.8 5659.3 5664.9 5538.6 5629.1 5666.4 5669.5 5678.9 4377.5 4432.1 4438.1 4449.3 4475.1 3972.5 3986.4 3987.9 3994.1 4018.2 5329.4 5385.4 5428.4 5428.9 5449.2 5696.0 5770.9 5783.3 5821.9 5822.3 5376.3 5385.5 5389.2 5390.4 5394.5 4904.2 4935.3 4936.5 4952.9 4954.2 5767.5 5819.9 5822.4 5887.4 5954.8 5800.9 5809.9 5827.8 5827.9 5838.4 5775.9 5885.1 5994.0 6042.8 6064.8 5594.6 5628.5 5675.5 5678.7 5720.1 5738.8 5776.5 5779.2 5784.9 5810.3 5555.5 5617.2 5642.7 5648.2 5687.5 5625.3 5698.4 5717.4 5721.2 5728.1 5581.4 5600.1 5627.6 5635.3 5641.4 5443.1 5546.7 5580.2 5669.1 5679.6 5436.7 5448.6 5461.4 5471.5 5502.7 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#1] ext.html Cycles:180 Average:40498.14 Median:35652.97 stddev:62089.92 (174.2%) stddev-sans-first:62191.55 02:04:56 INFO - PROCESS | 20493 | Values: 524.6 555.5 597.4 605.3 606.8 34822.0 35652.3 35653.6 35805.3 35830.5 37999.6 38384.8 38410.6 38445.8 38501.2 8463.4 8577.7 8610.6 8624.6 8637.7 8402.7 8460.7 8520.9 8696.4 8721.4 8671.0 8738.4 8786.0 8788.0 8814.6 8593.7 8688.0 8711.9 8712.0 8741.2 8518.2 8655.0 8665.4 8694.5 8700.5 38827.0 38895.4 38968.6 39252.6 39280.2 3059.7 3221.6 3317.8 3500.6 3627.2 29213.6 29239.6 29698.9 30048.2 30587.0 3736.6 3753.4 3764.6 3814.2 3816.8 196046.0 196734.0 196744.0 196967.0 197041.0 50233.0 51455.0 52338.0 59369.4 60587.0 52454.5 52485.0 52502.5 52596.0 52672.5 15244.4 15371.8 15491.4 15513.8 15515.2 11149.8 11172.6 11190.7 11191.2 11291.2 19376.9 19475.3 19497.0 19515.3 19523.6 7694.1 7886.3 7992.9 8088.8 8094.7 872.4 896.9 914.8 919.5 946.5 25424.5 25618.2 25626.7 29114.7 29820.9 953.9 980.3 983.2 987.1 1050.2 13664.6 15565.5 15781.5 15791.8 16075.1 235318.0 237316.0 237390.0 237416.0 238763.0 47436.0 47801.5 47801.5 47828.8 47829.5 1274.7 1288.3 1291.9 1312.4 1319.8 27903.3 29108.3 29166.0 29249.9 29557.6 43612.0 44004.6 44080.6 44237.8 44358.0 274920.0 276828.0 276883.0 276917.0 277375.0 27476.2 27809.6 29750.0 31052.5 31578.2 36109.8 37541.6 39147.0 39165.2 40348.6 33354.5 33493.2 33520.8 33689.0 34306.7 34654.7 34654.7 34745.3 35459.8 36721.3 31904.7 32527.8 32630.2 32796.2 32867.2 30093.7 31485.7 31516.2 32146.0 32254.2 24431.3 24562.5 25008.2 25185.7 25384.6 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#2] jquery.html Cycles:180 Average:27596.59 Median:2444.81 stddev:87083.27 (3562.0%) stddev-sans-first:87303.53 02:04:56 INFO - PROCESS | 20493 | Values: 355.3 355.4 359.7 359.9 365.8 16213.3 16823.8 17397.8 17651.4 18037.3 11023.1 11776.6 16262.9 16270.4 16400.1 4851.2 5066.1 5083.7 5085.4 5089.0 5027.7 5082.1 5086.0 5087.5 5093.1 5031.0 5065.3 5079.1 5203.2 5206.4 5077.5 5079.6 5084.5 5117.6 5119.2 5174.5 5231.2 5240.4 5249.7 5270.2 12532.6 12751.4 19008.9 20291.2 20791.0 1890.6 1909.1 1993.0 2033.1 2082.5 9370.7 9383.1 9479.1 9547.4 9775.1 1765.9 1847.7 1850.8 1851.2 1853.3 52655.0 55788.4 55795.7 55891.7 56063.2 10121.4 10125.1 10131.5 10136.1 10181.4 12993.3 13042.2 13142.3 13160.7 13645.9 7643.7 7731.8 7748.1 7867.3 7907.7 7393.7 7414.5 7437.5 7481.3 7507.9 4449.0 4530.5 4533.3 4545.0 4556.1 1834.3 1840.6 1852.6 1880.2 1888.6 418.2 433.4 439.4 455.3 464.4 10961.8 11242.8 11392.7 11599.3 11618.3 440.7 452.1 461.8 465.3 474.0 6045.8 6154.6 6204.7 6271.7 6310.7 519828.0 520621.0 520951.0 550823.0 550855.0 46419.8 80374.6 81255.0 81396.0 84024.2 487.7 491.3 491.3 491.8 492.8 10154.2 10270.2 10472.5 10616.0 14874.9 19093.2 31392.8 32241.7 33138.5 33768.5 42351.6 47419.8 49370.0 49780.8 49940.3 9672.9 9797.4 9849.5 9901.2 9909.7 11922.2 12063.8 12101.5 12121.3 12144.8 12027.4 14981.7 15028.5 15056.8 15122.7 12358.9 14504.7 14751.2 14964.6 15167.8 14986.6 15045.2 15198.2 15198.4 15594.2 9741.0 9793.6 9828.7 9912.0 10001.7 11703.5 15039.7 15052.2 15079.1 15209.5 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#3] mootools.html Cycles:180 Average:5353.83 Median:6106.95 stddev:2762.87 (45.2%) stddev-sans-first:2755.01 02:04:56 INFO - PROCESS | 20493 | Values: 1445.7 1448.8 1599.9 1757.1 1796.1 6962.3 7074.4 7606.5 7737.3 7758.7 7220.0 7297.4 7324.6 7377.9 7390.1 2296.5 2311.2 2333.1 2338.4 2343.3 2250.1 2281.7 2283.8 2284.3 2292.1 2235.3 2253.4 2280.8 2291.5 2300.8 2251.4 2304.7 2318.8 2320.5 2325.5 2312.9 2331.9 2339.2 2342.3 2349.8 7698.8 7759.0 7765.5 7790.6 7817.8 4579.5 4591.2 4596.1 4648.2 4651.0 2965.9 3041.0 3074.1 3075.3 3107.6 986.1 991.9 1748.8 1770.3 1787.4 10736.9 10814.2 10899.1 10900.1 10920.3 4169.8 4191.9 4229.5 4264.0 4272.7 8693.7 8827.5 8830.7 8840.1 8867.7 4645.6 4649.3 4652.9 4657.7 4658.1 4236.2 4305.8 4332.0 4337.4 4338.2 3509.2 3509.4 3510.2 3534.7 3556.1 1027.2 1031.6 1035.3 1058.0 1058.4 1310.1 1321.6 1332.2 1364.3 1365.2 7134.9 7226.8 7392.1 7399.7 7421.4 469.1 472.5 505.4 506.5 507.9 5714.4 5742.8 5754.1 5766.2 5804.7 8807.8 9333.8 9384.7 9408.7 9538.2 9217.5 9282.3 9325.5 9375.1 9385.7 6938.8 7060.1 7083.5 7119.5 7306.5 7195.8 7216.1 7225.6 7230.8 7261.5 7888.1 8011.1 8184.2 8203.4 8293.4 8403.1 8410.4 8424.8 8440.3 8468.4 6428.8 6519.7 6566.4 6576.6 6809.2 6889.6 6953.9 6960.1 6980.4 7006.2 6571.2 6971.2 6996.3 7022.2 7119.5 6612.2 6651.6 6670.2 6777.6 7018.2 6649.0 6699.4 6716.7 6743.9 6752.8 6068.4 6076.6 6109.8 6115.7 6126.9 6104.1 6120.2 6128.4 6159.2 6162.9 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#4] prototype.html Cycles:180 Average:5494.01 Median:6254.53 stddev:1677.60 (26.8%) stddev-sans-first:1637.09 02:04:56 INFO - PROCESS | 20493 | Values: 339.8 347.3 348.1 348.2 350.2 6132.3 6151.7 6161.5 6236.3 6296.4 6139.1 6189.9 6205.6 6207.3 6208.1 4688.4 4698.5 4700.1 4706.3 4709.0 4666.2 4692.4 4708.0 4717.8 4723.0 4471.9 4528.5 4605.9 4639.3 4654.0 4589.9 4602.6 4608.0 4616.7 4631.5 3958.1 3970.5 3978.8 4017.7 4030.2 5818.5 5875.2 5876.6 5879.0 5879.6 5282.6 5436.7 5452.0 5462.0 5485.9 6493.6 6504.7 6574.2 6575.3 6577.3 4467.1 4514.5 4519.8 4520.2 4525.0 6742.9 6747.8 6803.9 6819.6 6886.0 4609.9 4610.8 4661.1 4664.3 4673.6 4660.9 4675.4 4694.3 4694.3 4698.6 5440.6 5447.8 5454.9 5464.5 5465.8 6452.1 6618.2 6619.5 6629.2 6629.4 1626.1 1631.0 1636.3 1638.8 1638.9 1106.6 1112.4 1114.8 1114.9 1130.4 6322.7 6328.4 6332.6 6340.7 6342.7 6744.8 6802.7 6813.5 6819.9 6821.1 6076.9 6252.5 6256.5 6310.8 6320.1 3638.9 3682.7 3688.2 3702.6 3747.1 7164.8 7196.0 7202.7 7204.6 7210.9 6809.7 6973.1 6980.1 6992.8 7005.8 7143.4 7147.8 7218.0 7221.0 7226.9 6780.6 6781.7 6784.9 6791.6 6812.7 6542.9 6698.7 6720.4 6763.9 6817.4 7175.8 7204.0 7217.1 7218.2 7219.3 4737.7 4786.1 4786.5 4789.4 4793.8 6621.7 6754.8 6759.4 6776.0 6791.9 6519.3 6546.1 6548.9 6611.5 6614.2 6485.4 6559.4 6569.3 6577.0 6578.0 6304.6 6447.4 6452.3 6458.4 6470.9 6609.9 6611.4 6612.7 6624.6 6625.5 6320.7 6406.0 6419.6 6434.4 6435.5 02:04:56 INFO - PROCESS | 20493 | 02:04:56 INFO - PROCESS | 20493 | [#5] yui.html Cycles:180 Average:13146.59 Median:48955.01 stddev:15374.90 (31.4%) stddev-sans-first:15389.35 02:04:56 INFO - PROCESS | 20493 | Values: 641.2 649.9 664.3 674.3 698.6 11867.7 12047.5 12054.2 12292.1 12360.8 12695.1 12819.0 12942.9 13000.4 13044.4 804.9 805.6 816.1 817.2 818.4 792.5 799.0 799.7 802.8 804.6 845.6 846.0 849.2 849.8 850.3 847.4 849.0 849.2 851.4 853.4 611.6 628.1 628.7 631.6 633.6 11964.2 12031.5 12047.3 12141.7 12240.0 11195.4 11335.4 11698.5 11813.3 12658.1 8963.6 9135.2 9186.4 9645.4 9769.3 3466.1 3483.3 3500.1 3500.6 3516.7 48443.0 48852.5 48904.3 49005.8 49039.0 9791.9 9867.0 9972.2 10003.3 10129.3 17467.5 17618.9 17669.4 17679.7 17690.2 7148.6 7176.3 7189.5 7311.0 7332.0 4113.5 4134.2 4158.4 4163.6 4174.8 3034.2 3037.3 3048.4 3048.9 3061.3 553.6 559.8 574.8 578.0 580.9 469.4 505.5 530.5 575.3 642.1 7780.7 7830.7 7861.3 8003.1 8110.1 552.3 589.5 609.5 622.6 626.3 3696.0 3705.0 4012.5 4058.4 4284.1 52508.7 55071.4 55212.7 55283.2 55307.2 48484.8 48711.5 49591.8 49811.8 50694.0 43616.5 43807.0 43829.0 44281.3 44312.8 7874.1 7896.6 7926.4 8083.0 8260.0 32803.5 33019.5 33107.0 33666.8 33698.3 41124.8 41870.4 41903.4 42008.6 42864.6 10519.7 10746.6 11011.6 11181.4 11295.9 10195.9 10297.0 10872.0 10942.7 11076.2 10358.2 10363.1 10373.2 10461.1 10499.0 10111.8 10261.7 10511.1 10786.1 10820.6 9642.7 9801.6 10132.7 10268.9 10676.6 9072.0 9122.6 9597.8 9663.8 9949.6 8991.6 9089.2 9104.4 9122.9 9227.1 02:04:56 INFO - PROCESS | 20493 | -------- Summary: end -------- 02:04:56 INFO - PROCESS | 20493 | 02:04:57 INFO - TEST-INFO | 20493: exit 0 02:04:57 INFO - TEST-OK | dromaeo_css | took 1110826ms 02:04:57 INFO - TEST-START | kraken 02:04:57 INFO - operating with platform_type : linux_ 02:04:57 INFO - Initialising browser for kraken test... 02:04:57 INFO - TEST-INFO | started process 20730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiKJjAA/profile http://localhost:55473/getInfo.html) 02:05:01 INFO - PROCESS | 20730 | __metrics Screen width/height:1600/1200 02:05:01 INFO - PROCESS | 20730 | colorDepth:24 02:05:01 INFO - PROCESS | 20730 | Browser inner width/height: 1024/697 02:05:01 INFO - PROCESS | 20730 | __metrics 02:05:01 INFO - PROCESS | 20730 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:05:02 INFO - TEST-INFO | 20730: exit 0 02:05:02 INFO - Browser initialized. 02:05:02 INFO - Running cycle 1/1 for kraken test... 02:05:02 INFO - TEST-INFO | started process 20853 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiKJjAA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:05:13 INFO - PROCESS | 20853 | RSS: Main: 150032384 02:05:13 INFO - PROCESS | 20853 | 02:05:16 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55473/tests/kraken/driver.html?testName=audio-beat-detection) 02:05:17 INFO - PROCESS | 20853 | RSS: Main: 151064576 02:05:17 INFO - PROCESS | 20853 | 02:05:19 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55473/tests/kraken/driver.html?testName=audio-dft) 02:05:20 INFO - PROCESS | 20853 | RSS: Main: 149872640 02:05:20 INFO - PROCESS | 20853 | 02:05:23 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55473/tests/kraken/driver.html?testName=audio-fft) 02:05:23 INFO - PROCESS | 20853 | RSS: Main: 146128896 02:05:23 INFO - PROCESS | 20853 | 02:05:25 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55473/tests/kraken/driver.html?testName=audio-oscillator) 02:05:26 INFO - PROCESS | 20853 | RSS: Main: 145846272 02:05:26 INFO - PROCESS | 20853 | 02:05:28 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:29 INFO - PROCESS | 20853 | RSS: Main: 146259968 02:05:29 INFO - PROCESS | 20853 | 02:05:32 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55473/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:32 INFO - PROCESS | 20853 | RSS: Main: 147648512 02:05:32 INFO - PROCESS | 20853 | 02:05:36 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55473/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:36 INFO - PROCESS | 20853 | RSS: Main: 148844544 02:05:36 INFO - PROCESS | 20853 | 02:05:39 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55473/tests/kraken/driver.html?testName=json-parse-financial) 02:05:40 INFO - PROCESS | 20853 | RSS: Main: 147861504 02:05:40 INFO - PROCESS | 20853 | 02:05:41 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:42 INFO - PROCESS | 20853 | RSS: Main: 149102592 02:05:42 INFO - PROCESS | 20853 | 02:05:44 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:44 INFO - PROCESS | 20853 | RSS: Main: 148533248 02:05:44 INFO - PROCESS | 20853 | 02:05:46 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:47 INFO - PROCESS | 20853 | RSS: Main: 148758528 02:05:47 INFO - PROCESS | 20853 | 02:05:49 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:50 INFO - PROCESS | 20853 | RSS: Main: 148275200 02:05:50 INFO - PROCESS | 20853 | 02:05:53 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:53 INFO - PROCESS | 20853 | RSS: Main: 148422656 02:05:53 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | Cycle 1(1): loaded http://localhost:55473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55473/tests/kraken/driver.html?testName=ai-astar) 02:05:55 INFO - PROCESS | 20853 | RSS: Main: 149651456 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | __start_tp_report 02:05:55 INFO - PROCESS | 20853 | _x_x_mozilla_page_load 02:05:55 INFO - PROCESS | 20853 | _x_x_mozilla_page_load_details 02:05:55 INFO - PROCESS | 20853 | |i|pagename|runs| 02:05:55 INFO - PROCESS | 20853 | |0;ai-astar;113;107;112;112;111;122;112;112;110;112 02:05:55 INFO - PROCESS | 20853 | |1;audio-beat-detection;156;134;149;163;124;163;158;127;157;126 02:05:55 INFO - PROCESS | 20853 | |2;audio-dft;162;162;163;161;163;161;162;163;170;163 02:05:55 INFO - PROCESS | 20853 | |3;audio-fft;71;73;72;73;72;142;71;75;74;72 02:05:55 INFO - PROCESS | 20853 | |4;audio-oscillator;97;96;141;95;98;97;140;96;97;141 02:05:55 INFO - PROCESS | 20853 | |5;imaging-gaussian-blur;110;110;110;111;109;110;110;110;110;110 02:05:55 INFO - PROCESS | 20853 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;147 02:05:55 INFO - PROCESS | 20853 | |7;imaging-desaturate;96;96;96;96;97;98;97;96;97;96 02:05:55 INFO - PROCESS | 20853 | |8;json-parse-financial;59;68;59;61;59;61;60;59;57;57 02:05:55 INFO - PROCESS | 20853 | |9;json-stringify-tinderbox;69;68;67;67;68;69;68;68;67;68 02:05:55 INFO - PROCESS | 20853 | |10;stanford-crypto-aes;94;88;86;88;87;86;88;87;87;86 02:05:55 INFO - PROCESS | 20853 | |11;stanford-crypto-ccm;125;124;125;122;126;119;123;119;128;125 02:05:55 INFO - PROCESS | 20853 | |12;stanford-crypto-pbkdf2;149;166;151;151;154;139;153;155;156;142 02:05:55 INFO - PROCESS | 20853 | |13;stanford-crypto-sha256-iterative;70;72;69;70;71;69;69;68;74;68 02:05:55 INFO - PROCESS | 20853 | __end_tp_report 02:05:55 INFO - PROCESS | 20853 | __start_cc_report 02:05:55 INFO - PROCESS | 20853 | _x_x_mozilla_cycle_collect,767 02:05:55 INFO - PROCESS | 20853 | __end_cc_report 02:05:55 INFO - PROCESS | 20853 | __startTimestamp1452074755651__endTimestamp 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | ------- Summary: start ------- 02:05:55 INFO - PROCESS | 20853 | Number of tests: 14 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:4.02 02:05:55 INFO - PROCESS | 20853 | Values: 113.0 107.0 112.0 112.0 111.0 122.0 112.0 112.0 110.0 112.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:156.50 stddev:16.12 (10.3%) stddev-sans-first:16.67 02:05:55 INFO - PROCESS | 20853 | Values: 156.0 134.0 149.0 163.0 124.0 163.0 158.0 127.0 157.0 126.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.58 (1.6%) stddev-sans-first:2.71 02:05:55 INFO - PROCESS | 20853 | Values: 162.0 162.0 163.0 161.0 163.0 161.0 162.0 163.0 170.0 163.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#3] audio-fft Cycles:10 Average:79.50 Median:72.50 stddev:22.00 (30.3%) stddev-sans-first:23.11 02:05:55 INFO - PROCESS | 20853 | Values: 71.0 73.0 72.0 73.0 72.0 142.0 71.0 75.0 74.0 72.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.50 stddev:21.32 (22.1%) stddev-sans-first:22.10 02:05:55 INFO - PROCESS | 20853 | Values: 97.0 96.0 141.0 95.0 98.0 97.0 140.0 96.0 97.0 141.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:05:55 INFO - PROCESS | 20853 | Values: 110.0 110.0 110.0 111.0 109.0 110.0 110.0 110.0 110.0 110.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:05:55 INFO - PROCESS | 20853 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 02:05:55 INFO - PROCESS | 20853 | Values: 96.0 96.0 96.0 96.0 97.0 98.0 97.0 96.0 97.0 96.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.50 stddev:3.13 (5.3%) stddev-sans-first:3.30 02:05:55 INFO - PROCESS | 20853 | Values: 59.0 68.0 59.0 61.0 59.0 61.0 60.0 59.0 57.0 57.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 02:05:55 INFO - PROCESS | 20853 | Values: 69.0 68.0 67.0 67.0 68.0 69.0 68.0 68.0 67.0 68.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:2.36 (2.7%) stddev-sans-first:0.87 02:05:55 INFO - PROCESS | 20853 | Values: 94.0 88.0 86.0 88.0 87.0 86.0 88.0 87.0 87.0 86.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.00 stddev:2.91 (2.3%) stddev-sans-first:3.05 02:05:55 INFO - PROCESS | 20853 | Values: 125.0 124.0 125.0 122.0 126.0 119.0 123.0 119.0 128.0 125.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:153.50 stddev:7.49 (4.9%) stddev-sans-first:7.88 02:05:55 INFO - PROCESS | 20853 | Values: 149.0 166.0 151.0 151.0 154.0 139.0 153.0 155.0 156.0 142.0 02:05:55 INFO - PROCESS | 20853 | 02:05:55 INFO - PROCESS | 20853 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.89 (2.7%) stddev-sans-first:2.00 02:05:55 INFO - PROCESS | 20853 | Values: 70.0 72.0 69.0 70.0 71.0 69.0 69.0 68.0 74.0 68.0 02:05:55 INFO - PROCESS | 20853 | -------- Summary: end -------- 02:05:55 INFO - PROCESS | 20853 | 02:05:56 INFO - TEST-INFO | 20853: exit 0 02:05:56 INFO - TEST-OK | kraken | took 59507ms 02:05:56 INFO - TEST-START | v8_7 02:05:56 INFO - operating with platform_type : linux_ 02:05:56 INFO - Initialising browser for v8_7 test... 02:05:56 INFO - TEST-INFO | started process 21138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfCgeDU/profile http://localhost:55473/getInfo.html) 02:06:00 INFO - PROCESS | 21138 | __metrics Screen width/height:1600/1200 02:06:00 INFO - PROCESS | 21138 | colorDepth:24 02:06:00 INFO - PROCESS | 21138 | Browser inner width/height: 1024/697 02:06:00 INFO - PROCESS | 21138 | __metrics 02:06:00 INFO - PROCESS | 21138 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:06:01 INFO - TEST-INFO | 21138: exit 0 02:06:01 INFO - Browser initialized. 02:06:01 INFO - Running cycle 1/1 for v8_7 test... 02:06:01 INFO - TEST-INFO | started process 21260 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfCgeDU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:13 INFO - PROCESS | 21260 | RSS: Main: 150487040 02:06:13 INFO - PROCESS | 21260 | 02:06:34 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:55473/tests/v8_7/run.html (next: http://localhost:55473/tests/v8_7/run.html) 02:06:35 INFO - PROCESS | 21260 | RSS: Main: 146333696 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | __start_tp_report 02:06:35 INFO - PROCESS | 21260 | _x_x_mozilla_page_load 02:06:35 INFO - PROCESS | 21260 | _x_x_mozilla_page_load_details 02:06:35 INFO - PROCESS | 21260 | |i|pagename|runs| 02:06:35 INFO - PROCESS | 21260 | |0;Richards;168.09547823163558 02:06:35 INFO - PROCESS | 21260 | |1;DeltaBlue;188.64365214110546 02:06:35 INFO - PROCESS | 21260 | |2;Encrypt;279.9552071668533 02:06:35 INFO - PROCESS | 21260 | |3;Decrypt;5263.1578947368425 02:06:35 INFO - PROCESS | 21260 | |4;RayTrace;1063.8297872340424 02:06:35 INFO - PROCESS | 21260 | |5;Earley;707.2135785007072 02:06:35 INFO - PROCESS | 21260 | |6;Boyer;12525 02:06:35 INFO - PROCESS | 21260 | |7;RegExp;27513.513513513513 02:06:35 INFO - PROCESS | 21260 | |8;Splay;680.8367071524966 02:06:35 INFO - PROCESS | 21260 | |9;NavierStokes;4830.917874396136 02:06:35 INFO - PROCESS | 21260 | __end_tp_report 02:06:35 INFO - PROCESS | 21260 | __startTimestamp1452074795166__endTimestamp 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | ------- Summary: start ------- 02:06:35 INFO - PROCESS | 21260 | Number of tests: 10 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#0] Richards Cycles:1 Average:168.10 Median:168.10 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 168.1 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 188.6 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 280.0 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 5263.2 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 1063.8 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#5] Earley Cycles:1 Average:707.21 Median:707.21 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 707.2 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 12525.0 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#7] RegExp Cycles:1 Average:27513.51 Median:27513.51 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 27513.5 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#8] Splay Cycles:1 Average:680.84 Median:680.84 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 680.8 02:06:35 INFO - PROCESS | 21260 | 02:06:35 INFO - PROCESS | 21260 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:06:35 INFO - PROCESS | 21260 | Values: 4830.9 02:06:35 INFO - PROCESS | 21260 | -------- Summary: end -------- 02:06:35 INFO - PROCESS | 21260 | 02:06:36 INFO - TEST-INFO | 21260: exit 0 02:06:36 INFO - TEST-OK | v8_7 | took 39452ms 02:06:36 INFO - SUITE-END | took 1209s 02:06:36 INFO - Completed test suite (00:20:09) 02:06:36 INFO - Working with test: dromaeo_css 02:06:36 INFO - Generating results file: dromaeo_css 02:06:36 INFO - Working with test: kraken 02:06:36 INFO - Generating results file: kraken 02:06:36 INFO - javascript benchmark 02:06:36 INFO - Working with test: v8_7 02:06:36 INFO - Generating results file: v8_7 02:06:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:06:36 INFO - process_Request line: dromaeo_css 6744.85 graph.html#tests=[[72,64,43]] 02:06:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:36 INFO - process_Request line: kraken 1523.90 graph.html#tests=[[232,64,43]] 02:06:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:36 INFO - process_Request line: v8_7 20871.67 graph.html#tests=[[230,64,43]] 02:06:36 INFO - RETURN: dromaeo_css: 6744.85 02:06:36 INFO - RETURN: kraken: 1523.90 02:06:36 INFO - RETURN: v8_7: 20871.67 02:06:36 INFO - javascript benchmark 02:06:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3101.643311019233, 3165.5093460513626, 3194.361127774446, 3195.5224774028775, 3217.2600301930556, 5145.794168233266, 5308.761105750241, 5314.335708036496, 5321.840344789653, 5341.0, 5225.216217567367, 5284.365876094865, 5318.494742999418, 5343.545798607113, 5473.17902314653, 4792.089502994438, 4794.472608013116, 4795.520447955194, 4834.830780922668, 4946.332245146913, 4896.755162241873, 4900.901981960359, 4910.067087253428, 4922.360093187881, 4930.80276788928, 4710.74090924999, 4792.400949881265, 4820.493848145947, 4917.36074310341, 4942.036302920932, 4875.731834749087, 4890.755462226874, 4891.144049791308, 4903.509649035103, 4939.827106051271, 4706.058788242365, 4861.975690121527, 4873.926891096637, 4884.169691152512, 4915.16442204826, 5121.8463446096675, 5154.510321519487, 5160.690358578498, 5180.378354597435, 5197.506236907526, 5737.684427356494, 5759.827205183851, 5760.0783874579865, 5762.971185144047, 5771.740271687784, 5680.4319568042865, 5794.246747922785, 5803.82588522345, 5820.068788993741, 5822.650640961556, 5285.920711189336, 5321.574274058066, 5322.33470816148, 5333.386660534049, 5353.330833645794, 5842.795502157404, 5856.355800861902, 5879.294484661782, 5881.264841894763, 5899.734511946973, 5599.468050535193, 5642.26650535436, 5649.350324712628, 5652.6325788824415, 5691.544676425959, 5677.517411020027, 5683.914741278884, 5685.800996965087, 5688.288963879515, 5737.483626473554, 5608.49523542875, 5651.943480565142, 5652.802151924663, 5659.292588426447, 5664.915026274609, 5538.6399884007415, 5629.071203251499, 5666.433356664301, 5669.461401166883, 5678.886422271614, 4377.4965878923695, 4432.13573353193, 4438.112377524508, 4449.28811390176, 4475.060237350128, 3972.463717398172, 3986.421968814506, 3987.9202415951518, 3994.121293315466, 4018.176273863851, 5329.387120481117, 5385.353757549119, 5428.430014848463, 5428.864278393072, 5449.237106805051, 5695.971520142372, 5770.855728606734, 5783.277090363705, 5821.88356232873, 5822.272215973004, 5376.327959005124, 5385.515303622693, 5389.191621256843, 5390.407055223922, 5394.487523685244, 4904.215325547966, 4935.259711043373, 4936.481669424658, 4952.851414457572, 4954.157793175169, 5767.452092051249, 5819.854503637443, 5822.446867547576, 5887.4406931341455, 5954.76180952757, 5800.854978625568, 5809.8547536311935, 5827.79602713903, 5827.8834423310445, 5838.357780644211, 5775.884482310246, 5885.087811389241, 5993.9700301498215, 6042.848928776816, 6064.848378790565, 5594.580406469449, 5628.549716022627, 5675.489205971482, 5678.716064196857, 5720.141978703228, 5738.770449182153, 5776.480116789509, 5779.190913272229, 5784.94215057844, 5810.331811841692, 5555.50000499957, 5617.241672374341, 5642.746076426489, 5648.237487939075, 5687.544996400361, 5625.296837895263, 5698.430156984268, 5717.42825717425, 5721.170430287668, 5728.054870946414, 5581.358143813351, 5600.0759874620235, 5627.634203776742, 5635.267415235993, 5641.435856414326, 5443.129099344086, 5546.722663866871, 5580.190872323409, 5669.092945128759, 5679.630823996427, 5436.668016335865, 5448.591355648263, 5461.371942226536, 5471.452854714656, 5502.724863756716], "unit": "score", "name": "dojo.html", "value": 5283.691950518882}, {"lowerIsBetter": false, "replicates": [524.6013030097125, 555.469526602095, 597.3817099302223, 605.261580871337, 606.790657223258, 34822.0, 35652.2869542609, 35653.64346356536, 35805.2838943221, 35830.46254306184, 37999.62000379995, 38384.80807595965, 38410.61589384105, 38445.807770961175, 38501.22997540048, 8463.365247606424, 8577.699780507683, 8610.56947152643, 8624.611892464824, 8637.697680581181, 8402.663893444254, 8460.66157353705, 8520.914790852104, 8696.39125261232, 8721.433106848066, 8670.956645216766, 8738.432001919886, 8786.0, 8788.03331633523, 8814.603342849556, 8593.742187734379, 8688.044315125331, 8711.869321960145, 8712.0416754157, 8741.169588889108, 8518.23335899772, 8655.0, 8665.39342246043, 8694.521801300925, 8700.521471319074, 38827.0, 38895.41656875149, 38968.610313897065, 39252.60747392547, 39280.21439571221, 3059.6787337329483, 3221.629512606057, 3317.7511686623598, 3500.6149323574386, 3627.220147668264, 29213.561796573067, 29239.56140657892, 29698.85150574255, 30048.248793780112, 30587.0, 3736.57029441615, 3753.3619284721663, 3764.642358975893, 3814.16088460541, 3816.7709937403843, 196046.0, 196734.0, 196744.0, 196967.0, 197041.0, 50233.0, 51455.0, 52338.0, 59369.40630593725, 60587.0, 52454.47545524572, 52485.0, 52502.47497525052, 52596.0, 52672.473275266755, 15244.390224391122, 15371.769423458658, 15491.380344786308, 15513.767293490606, 15515.224238788016, 11149.832752508719, 11172.608958686407, 11190.66428007161, 11191.216614837045, 11291.153163512769, 19376.93426861536, 19475.318363857197, 19497.0, 19515.316963906196, 19523.609527809363, 7694.115176754744, 7886.250806173404, 7992.920070799334, 8088.797780055545, 8094.676212951534, 872.4372779557277, 896.8699538566872, 914.8170365926841, 919.4850883505259, 946.5456580841235, 25424.491510169693, 25618.23145305644, 25626.74373256281, 29114.708852911623, 29820.85089574538, 953.8998405167357, 980.3284749946309, 983.1643103362085, 987.0672214756986, 1050.1965996013057, 13664.590062298146, 15565.533034008999, 15781.526554203392, 15791.763123553155, 16075.115868627105, 235318.0, 237316.0, 237390.0, 237416.0, 238763.0, 47436.0, 47801.521984780404, 47801.521984780404, 47828.7608561955, 47829.521704782506, 1274.7004453953314, 1288.2850018239967, 1291.9135596012372, 1312.4290933443983, 1319.7822359310799, 27903.302417439725, 29108.272293191993, 29166.0, 29249.85375073196, 29557.556636650897, 43612.0, 44004.559954401324, 44080.559194408925, 44237.778811107026, 44358.0, 274920.0, 276828.0, 276883.0, 276917.0, 277375.0, 27476.17571472859, 27809.58285625677, 29749.958751443595, 31052.534211986385, 31578.210544736565, 36109.81945090258, 37541.624583753815, 39147.0, 39165.216695666495, 40348.596514034485, 33354.4996825043, 33493.16267093342, 33520.83239583884, 33689.0, 34306.65693343035, 34654.653453465144, 34654.653453465144, 34745.30509389849, 35459.82270088633, 36721.26557468889, 31904.68095319017, 32527.837360813046, 32630.184245394055, 32796.18009549685, 32867.178320542174, 30093.69906300909, 31485.685143149192, 31516.212094697818, 32146.0, 32254.19364515812, 24431.26706198817, 24562.50874982526, 25008.249752507454, 25185.74814251834, 25384.619230711924], "unit": "score", "name": "ext.html", "value": 17509.433793466043}, {"lowerIsBetter": false, "replicates": [355.3000588839984, 355.35325707212866, 359.68527538403896, 359.88843458527856, 365.7750483452676, 16213.270402831871, 16823.83176168238, 17397.782155249108, 17651.382201622946, 18037.27850885963, 11023.118150547956, 11776.646700598996, 16262.918685406587, 16270.43053493128, 16400.09799461032, 4851.175300198957, 5066.088104141253, 5083.745812709368, 5085.364329458817, 5089.033083714083, 5027.673201241926, 5082.110630639641, 5086.0, 5087.465816089313, 5093.057784309896, 5030.974845125769, 5065.265536497206, 5079.060373830835, 5203.245529398235, 5206.375234971809, 5077.543021128079, 5079.6190285728535, 5084.491550844923, 5117.590592752608, 5119.1809310510325, 5174.534291913746, 5231.163013917793, 5240.423553409122, 5249.737513124329, 5270.183121616155, 12532.561360352343, 12751.42618582166, 19008.90495547527, 20291.188352465884, 20791.0, 1890.6124244529838, 1909.0550177662008, 1992.9701054484194, 2033.1155947163031, 2082.4897900014444, 9370.67202647904, 9383.06169383063, 9479.052094790535, 9547.379420337656, 9775.071368220008, 1765.8675599330102, 1847.7413162157309, 1850.777906651197, 1851.2317388283846, 1853.2586965213889, 52655.0, 55788.442115579135, 55795.72102139463, 55891.72054139703, 56063.15905261384, 10121.392716437038, 10125.088742013255, 10131.544080516247, 10136.138428233535, 10181.440020798778, 12993.285369304589, 13042.217466952014, 13142.34288285601, 13160.670983225496, 13645.863541364657, 7643.7324693635455, 7731.7680469586, 7748.108967468813, 7867.252611001945, 7907.655698531264, 7393.704251829867, 7414.518056326321, 7437.479376443597, 7481.289277518627, 7507.873818927204, 4448.955510444919, 4530.478994915561, 4533.297338912474, 4544.977275113603, 4556.088782243498, 1834.3488061737892, 1840.6226723521645, 1852.5646473078816, 1880.1915176473974, 1888.5845114074882, 418.2429802058284, 433.3586292287432, 439.4484921423657, 455.27838376174134, 464.35918432562846, 10961.83557246642, 11242.775144497227, 11392.715182120513, 11599.304041757352, 11618.302901825917, 440.6716995838121, 452.093552427381, 461.8498987828969, 465.3206318774559, 473.995260047402, 6045.8488537786025, 6154.630722156685, 6204.658743769046, 6271.655058971709, 6310.747570097236, 519828.0, 520621.0, 520951.0, 550823.0, 550855.0, 46419.82221600072, 80374.598127009, 81255.0, 81396.0, 84024.15975840163, 487.74393443441767, 491.29008582597805, 491.30235066206075, 491.75903807134245, 492.7856382473635, 10154.238432117472, 10270.229732770222, 10472.476376181314, 10616.0, 14874.925625371803, 19093.23627054958, 31392.843035784674, 32241.677583224806, 33138.50292245667, 33768.50477889178, 42351.57648423476, 47419.76290118528, 49370.01259974852, 49780.75109624429, 49940.250896235855, 9672.854907176257, 9797.412155270707, 9849.507524623883, 9901.15840153595, 9909.65316213929, 11922.165448418527, 12063.75872482563, 12101.515939362678, 12121.333326667118, 12144.817827732768, 12027.398630068286, 14981.726553243096, 15028.474003409829, 15056.774148388002, 15122.697546048797, 12358.938205308916, 14504.709905801614, 14751.188684622448, 14964.625884352978, 15167.848321516643, 14986.550403487912, 15045.247737613294, 15198.164100974553, 15198.392064317304, 15594.220288985733, 9741.0, 9793.559289832117, 9828.655997040069, 9911.950440247752, 10001.74995625086, 11703.531858725897, 15039.699206016037, 15052.247387630356, 15079.095254284777, 15209.543713688165], "unit": "score", "name": "jquery.html", "value": 7842.449241446557}, {"lowerIsBetter": false, "replicates": [1445.71808497343, 1448.8261408630965, 1599.9120048397333, 1757.1126581076555, 1796.0929730486112, 6962.268961759006, 7074.398676112537, 7606.543607383561, 7737.342325902291, 7758.689652413904, 7220.0, 7297.379722723562, 7324.633768311576, 7377.889331660016, 7390.113186417624, 2296.4832912594657, 2311.167979527369, 2333.0667732906804, 2338.4387746940697, 2343.297010896733, 2250.144944920936, 2281.7147856517936, 2283.8058765004994, 2284.326123793485, 2292.071710957065, 2235.2958817972367, 2253.43664083979, 2280.794728474437, 2291.472961218921, 2300.769923007703, 2251.425886398974, 2304.6888670029584, 2318.802901753353, 2320.512692334612, 2325.5116425550655, 2312.9306120816404, 2331.8717470539113, 2339.239747082205, 2342.26218741096, 2349.7532759060223, 7698.807529811799, 7758.952541406894, 7765.456418050739, 7790.649420776079, 7817.804554886116, 4579.4504659440745, 4591.196540605414, 4596.103759766846, 4648.209804333238, 4650.953490465085, 2965.851707414642, 3040.9695903040906, 3074.123874695701, 3075.2926826829953, 3107.6115485564305, 986.1322036607739, 991.8561808537794, 1748.8251174882537, 1770.3184274054454, 1787.4101546489628, 10736.892631073668, 10814.188935829765, 10899.12806975448, 10900.1279897608, 10920.2901811382, 4169.833206671699, 4191.8532851350055, 4229.534751177368, 4263.957360426418, 4272.743635381887, 8693.695720649874, 8827.514486703165, 8830.690925817566, 8840.115988401109, 8867.73396798097, 4645.558671926162, 4649.256119020941, 4652.883677908079, 4657.673962822638, 4658.138244424792, 4236.216299984451, 4305.827766889352, 4331.978340108342, 4337.392765012901, 4338.219120558329, 3509.2279698466295, 3509.350770107538, 3510.157562185057, 3534.699550538233, 3556.1287484566446, 1027.2398425165325, 1031.6131450705984, 1035.316690983947, 1057.9682609521574, 1058.439027315524, 1310.0567591334225, 1321.5837011341396, 1332.2206509192038, 1364.3382959264748, 1365.1808914651328, 7134.892976605355, 7226.783196504113, 7392.112946446461, 7399.667014984231, 7421.369183619345, 469.1180580508622, 472.46375363961465, 505.39605171820057, 506.5263978180413, 507.8755704852335, 5714.399988001283, 5742.827715168552, 5754.079347304411, 5766.163906233573, 5804.738786754606, 8807.779805504786, 9333.766655833659, 9384.718458446258, 9408.670696525589, 9538.23694104484, 9217.493037882847, 9282.257419406431, 9325.487098209527, 9375.10936461035, 9385.67150149755, 6938.757143499954, 7060.117485314336, 7083.539569927938, 7119.4660400470175, 7306.525075870158, 7195.784126476214, 7216.134063912364, 7225.5664660120565, 7230.819229519304, 7261.5280006799385, 7888.092869320101, 8011.078725946591, 8184.2224988625985, 8203.384746143944, 8293.377996650155, 8403.075661677089, 8410.411271211202, 8424.831503369776, 8440.324774017941, 8468.449550779425, 6428.839279017875, 6519.706613202512, 6566.376194261537, 6576.572522786004, 6809.182898052265, 6889.552179108542, 6953.930460695328, 6960.095187625576, 6980.371766541036, 7006.159260888726, 6571.211454625475, 6971.233164352018, 6996.300369963166, 7022.227554969051, 7119.501634885508, 6612.23959244693, 6651.567648102858, 6670.199576050711, 6777.593344399352, 7018.157821061505, 6649.03588979605, 6699.430548403246, 6716.697748601422, 6743.865122697421, 6752.763653272112, 6068.423499767515, 6076.635401875901, 6109.75560977556, 6115.724792384264, 6126.938730612816, 6104.145419641165, 6120.234970628671, 6128.387161283836, 6159.23009623797, 6162.938370616236], "unit": "score", "name": "mootools.html", "value": 4378.556000723718}, {"lowerIsBetter": false, "replicates": [339.79951828421235, 347.3296537682274, 348.07270852133564, 348.2390975718055, 350.21027582800787, 6132.325444201134, 6151.723172457233, 6161.507079433646, 6236.251649802019, 6296.401841825019, 6139.079138129283, 6189.907151392721, 6205.596636218643, 6207.286162091361, 6208.099825525296, 4688.367070445481, 4698.483166851644, 4700.106979673868, 4706.317583950326, 4709.0346478971815, 4666.160091183586, 4692.4369075710965, 4708.0, 4717.834875779348, 4722.97638511807, 4471.8658440246845, 4528.547145285478, 4605.861824145281, 4639.327297541854, 4653.953460465385, 4589.885252868671, 4602.562756538157, 4608.0, 4616.722996620197, 4631.4673812511655, 3958.0698535844053, 3970.5433875104445, 3978.8209530571194, 4017.678585713136, 4030.1536677297804, 5818.5054270386645, 5875.236219291507, 5876.647401155901, 5878.970605146947, 5879.588428809985, 5282.577393808486, 5436.728163591844, 5451.972740136313, 5461.972690136564, 5485.862853428656, 6493.610383376965, 6504.674766261668, 6574.2110946686225, 6575.342465753434, 6577.342265773432, 4467.128909862578, 4514.548545145492, 4519.796609152596, 4520.163769702615, 4525.0, 6742.898856517205, 6747.831304217385, 6803.863922721518, 6819.556728812611, 6886.035954966309, 4609.884752881205, 4610.838620648261, 4661.067786442725, 4664.277037059262, 4673.60274376675, 4660.883477913079, 4675.392199014106, 4694.342792009122, 4694.342792009122, 4698.577128058491, 5440.591955603346, 5447.782088716486, 5454.890902182014, 5464.480874316933, 5465.81367453014, 6452.09595783125, 6618.172728408949, 6619.5035372347265, 6629.204495460575, 6629.370209830058, 1626.0975158786987, 1631.037687764201, 1636.3454618152834, 1638.7787648667277, 1638.942637007699, 1106.568438309044, 1112.4326593437406, 1114.7603265298, 1114.8662160540787, 1130.423484023154, 6322.747090116436, 6328.398802113792, 6332.561963644031, 6340.714667839959, 6342.682865856688, 6744.83137921546, 6802.693878775467, 6813.454923606099, 6819.897701534481, 6821.147356580427, 6076.939230607726, 6252.531060170414, 6256.5307601930035, 6310.7791227306825, 6320.083587879732, 3638.872639457606, 3682.6869716073898, 3688.1927855351223, 3702.555693316819, 3747.100695833035, 7164.785056448315, 7195.96402017997, 7202.675879585431, 7204.639768011579, 7210.927890721131, 6809.693563789641, 6973.058637083929, 6980.057692211486, 6992.755253566101, 7005.754798582026, 7143.357097861322, 7147.785566433015, 7218.0, 7221.0, 7226.855462890818, 6780.593164410151, 6781.7287308509085, 6784.864302714017, 6791.558548694319, 6812.727490900308, 6542.934570654233, 6698.66506674674, 6720.361565651256, 6763.932360676527, 6817.386435220854, 7175.820604484721, 7203.963980180066, 7217.097862767154, 7218.242084581043, 7219.278072192738, 4737.668363214542, 4786.138495070921, 4786.521347865186, 4789.401324834395, 4793.784279707352, 6621.6689165540565, 6754.831129221809, 6759.357861003196, 6776.0, 6791.864162716619, 6519.315471875574, 6546.0508226307875, 6548.901766473411, 6611.471082313307, 6614.173228346457, 6485.44873685742, 6559.409653131241, 6569.277379488348, 6577.046328282277, 6578.013298005338, 6304.590201636879, 6447.355264473703, 6452.257990330984, 6458.354164583504, 6470.932296171079, 6609.900851487328, 6611.371919667624, 6612.669366531751, 6624.635645039569, 6625.536212465274, 6320.715567799552, 6405.967970160119, 6419.550631455753, 6434.420902118832, 6435.549511534147], "unit": "score", "name": "prototype.html", "value": 4948.299660722674}, {"lowerIsBetter": false, "replicates": [641.1664835713572, 649.9015225555515, 664.3323459922777, 674.3054653706682, 698.6227437183921, 11867.70330741732, 12047.51809927604, 12054.21647592907, 12292.078094142942, 12360.814587781191, 12695.11134220605, 12818.974482041438, 12942.935285323583, 13000.41498132584, 13044.413001414936, 804.9034115906085, 805.5529181304373, 816.0696805641574, 817.2032268538187, 818.4189225649795, 792.4888446951712, 799.0251892690936, 799.7081065411112, 802.7671975127236, 804.5775967616989, 845.5560830563973, 845.9577021148949, 849.1847826086934, 849.8470275350435, 850.26452118917, 847.4364547575855, 848.9915100849005, 849.1678155407674, 851.3614788908319, 853.4239388412858, 611.5871786544064, 628.0767272109991, 628.6730899932055, 631.6368088349218, 633.5660072850067, 11964.1625086244, 12031.51873925042, 12047.277163370138, 12141.696457588543, 12240.0, 11195.440227988567, 11335.37655428951, 11698.532058717641, 11813.29120252779, 12658.113932024762, 8963.55182240892, 9135.177833994905, 9186.356955013152, 9645.421274723469, 9769.267304952156, 3466.098814308298, 3483.2511010132944, 3500.114643458841, 3500.597431295408, 3516.718662507019, 48443.0, 48852.51147488515, 48904.26643600349, 49005.75497122527, 49039.0, 9791.853122203172, 9867.0, 9972.152367048737, 10003.2997690161, 10129.290949633454, 17467.47597572075, 17618.91190544039, 17669.381571645186, 17679.73480397795, 17690.203940822696, 7148.571085734872, 7176.282371762886, 7189.460790440738, 7311.0495635568095, 7331.963340183265, 4113.547509773923, 4134.193832202692, 4158.4178215049915, 4163.562825903297, 4174.77038762871, 3034.180771191766, 3037.3166037641795, 3048.420800047984, 3048.9390212196076, 3061.265296328865, 553.582045555611, 559.7844829740498, 574.8419184724235, 577.9508741756914, 580.94771470567, 469.3921371823497, 505.4970304546926, 530.4536327582596, 575.2952633024595, 642.1363266406676, 7780.727674531364, 7830.686772529149, 7861.331786798072, 8003.079645840687, 8110.107888132301, 552.3068548971096, 589.4842013238416, 609.4606273447941, 622.5673157155733, 626.3079297376424, 3695.9630403696156, 3705.0366904605, 4012.518497780227, 4058.3912413137673, 4284.121755040209, 52508.73745631324, 55071.449285507435, 55212.72393638006, 55283.170752438746, 55307.170392444146, 48484.757576211894, 48711.512884870695, 49591.75204123956, 49811.75094124506, 50694.0, 43616.47342343003, 43807.0, 43829.0, 44281.33577996332, 44312.77843610761, 7874.094479134973, 7896.62027833002, 7926.405519586169, 8082.959585202037, 8259.9587002067, 32803.507947380334, 33019.504707429885, 33107.0, 33666.83166584151, 33698.326033478705, 41124.79437602793, 41870.37194442025, 41903.371449428894, 42008.57991420169, 42864.57135428606, 10519.684409467729, 10746.623868164577, 11011.559537618727, 11181.440927953407, 11295.943520282346, 10195.949020254851, 10297.0, 10872.0, 10942.726431839268, 11076.224664273423, 10358.223133265186, 10363.119134873621, 10373.170146388422, 10461.110805581611, 10499.0, 10111.797764044824, 10261.74345641365, 10511.054005139575, 10786.137109031415, 10820.621278255223, 9642.662506812228, 9801.558929848317, 10132.696019119438, 10268.948655256676, 10676.62631807883, 9072.0, 9122.589483473392, 9597.808043839224, 9663.7987561348, 9949.602015919281, 8991.595378207865, 9089.181973622406, 9104.362694611578, 9122.90877091247, 9227.123423274777], "unit": "score", "name": "yui.html", "value": 5988.9251299684265}], "name": "dromaeo_css", "value": 6744.846944561505}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 112.0, 111.0, 122.0, 112.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [156.0, 134.0, 149.0, 163.0, 124.0, 163.0, 158.0, 127.0, 157.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 161.0, 162.0, 163.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 73.0, 72.0, 142.0, 71.0, 75.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 95.0, 98.0, 97.0, 140.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.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": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 98.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 68.0, 59.0, 61.0, 59.0, 61.0, 60.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [94.0, 88.0, 86.0, 88.0, 87.0, 86.0, 88.0, 87.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 125.0, 122.0, 126.0, 119.0, 123.0, 119.0, 128.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [149.0, 166.0, 151.0, 151.0, 154.0, 139.0, 153.0, 155.0, 156.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 69.0, 70.0, 71.0, 69.0, 69.0, 68.0, 74.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1523.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.09547823163558], "unit": "score", "name": "Richards", "value": 210.01159799999994}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1063.8297872340424], "unit": "score", "name": "RayTrace", "value": 695.5896600000003}, {"lowerIsBetter": false, "replicates": [707.2135785007072], "unit": "score", "name": "Earley", "value": 942.3786820000003}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [27513.513513513513], "unit": "score", "name": "RegExp", "value": 33.11045677799608}, {"lowerIsBetter": false, "replicates": [680.8367071524966], "unit": "score", "name": "Splay", "value": 119.69243012884048}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20871.674304595024}]} 02:06:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20871.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1523.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6744.85"}}} 02:06:36 INFO - Return code: 0 02:06:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:06:36 INFO - # TBPL SUCCESS # 02:06:36 INFO - Running post-action listener: _resource_record_post_action 02:06:36 INFO - Running post-run listener: _resource_record_post_run 02:06:37 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 16384; Write bytes: 576307200; Read time: 48; Write time: 361464 02:06:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237875200; Read time: 0; Write time: 198076 02:06:37 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 16384; Write bytes: 320671744; Read time: 48; Write time: 155648 02:06:37 INFO - Running post-run listener: _upload_blobber_files 02:06:37 INFO - Blob upload gear active. 02:06:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:06:37 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 02:06:37 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'] 02:06:37 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 02:06:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:06:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:06:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:38 INFO - (blobuploader) - INFO - Done attempting. 02:06:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:06:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:40 INFO - (blobuploader) - INFO - Done attempting. 02:06:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:06:40 INFO - Return code: 0 02:06:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:06:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:06:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55128e1530ed4aa975e7c64915612e9a1892b7f8b58679edf7fb0fc0a2e3e2e4a1bb0d944ddeb88399ca745899eff2421d6cf876c60b42341b6a4ebd92980aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f69094675acea9fe566dac188660acbe091bccc6090aa8e90d6e3944eea74f88d4e2d7bb70da3518c9ca8978d04188f8542216f17032451586adb4dda96eff8b"} 02:06:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:06:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:06:40 INFO - Contents: 02:06:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/55128e1530ed4aa975e7c64915612e9a1892b7f8b58679edf7fb0fc0a2e3e2e4a1bb0d944ddeb88399ca745899eff2421d6cf876c60b42341b6a4ebd92980aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f69094675acea9fe566dac188660acbe091bccc6090aa8e90d6e3944eea74f88d4e2d7bb70da3518c9ca8978d04188f8542216f17032451586adb4dda96eff8b"} 02:06:40 INFO - Copying logs to upload dir... 02:06:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.701466 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-06 02:06:40.839930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 02:06:40.843809) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 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/55128e1530ed4aa975e7c64915612e9a1892b7f8b58679edf7fb0fc0a2e3e2e4a1bb0d944ddeb88399ca745899eff2421d6cf876c60b42341b6a4ebd92980aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f69094675acea9fe566dac188660acbe091bccc6090aa8e90d6e3944eea74f88d4e2d7bb70da3518c9ca8978d04188f8542216f17032451586adb4dda96eff8b"} build_url:https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/LzPLR3JaSjWdNbnSLj9-Aw/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/55128e1530ed4aa975e7c64915612e9a1892b7f8b58679edf7fb0fc0a2e3e2e4a1bb0d944ddeb88399ca745899eff2421d6cf876c60b42341b6a4ebd92980aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f69094675acea9fe566dac188660acbe091bccc6090aa8e90d6e3944eea74f88d4e2d7bb70da3518c9ca8978d04188f8542216f17032451586adb4dda96eff8b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 02:06:40.868158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 02:06:40.868510) ========= 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=03627c79f6bb3d1578c4a402000001ba-1452072905.55143-599751937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 02:06:40.919949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 02:06:40.920274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 02:06:40.920591) ========= ========= Total master_lag: 0.30 =========