builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1452246269.39 results: success (0) buildid: 20160107233010 builduid: 6259bf93c39c4bf68e19a6afb4792aa2 revision: ad7d6390e0f5e807e026384d9ef970b3bb24421c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.389152) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.389675) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.389965) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006326 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.413942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.414279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.427760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.428146) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.483086) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.483366) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.483727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.484021) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 01:44:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-01-08 01:44:30 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.599404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.599688) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020419 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:29.662682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 01:44:29.663014) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad7d6390e0f5e807e026384d9ef970b3bb24421c --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 ad7d6390e0f5e807e026384d9ef970b3bb24421c --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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 01:44:30,388 truncating revision to first 12 chars 2016-01-08 01:44:30,388 Setting DEBUG logging. 2016-01-08 01:44:30,388 attempt 1/10 2016-01-08 01:44:30,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad7d6390e0f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 01:44:31,582 unpacking tar archive at: fx-team-ad7d6390e0f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482220 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-08 01:44:31.159345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:31.159654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:31.167363) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:31.167633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 01:44:31.168052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-01-08 01:44:31.168346) ========= /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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:44:31 INFO - MultiFileLogger online at 20160108 01:44:31 in /builds/slave/test-pgo 01:44:31 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:44:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:44:31 INFO - {'append_to_log': False, 01:44:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:44:31 INFO - 'blob_upload_branch': 'Fx-Team', 01:44:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:44:31 INFO - 'branch': 'Fx-Team', 01:44:31 INFO - 'buildbot_json_path': 'buildprops.json', 01:44:31 INFO - 'config_files': ('talos/linux_config.py',), 01:44:31 INFO - 'default_actions': ('clobber', 01:44:31 INFO - 'read-buildbot-config', 01:44:31 INFO - 'download-and-extract', 01:44:31 INFO - 'populate-webroot', 01:44:31 INFO - 'create-virtualenv', 01:44:31 INFO - 'install', 01:44:31 INFO - 'run-tests'), 01:44:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:44:31 INFO - 'download_minidump_stackwalk': True, 01:44:31 INFO - 'download_symbols': 'ondemand', 01:44:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:44:31 INFO - 'tooltool.py': '/tools/tooltool.py', 01:44:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:44:31 INFO - '/tools/misc-python/virtualenv.py')}, 01:44:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:44:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:44:31 INFO - 'installer_path': 'installer.exe', 01:44:31 INFO - 'log_level': 'info', 01:44:31 INFO - 'log_name': 'talos', 01:44:31 INFO - 'log_to_console': True, 01:44:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:44:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:44:31 INFO - 'opt_config_files': (), 01:44:31 INFO - 'pip_index': False, 01:44:31 INFO - 'sps_profile': False, 01:44:31 INFO - 'sps_profile_interval': 0, 01:44:31 INFO - 'suite': 'dromaeojs-e10s', 01:44:31 INFO - 'system_bits': '32', 01:44:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:44:31 INFO - 'title': 'talos-linux64-ix-004', 01:44:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:44:31 INFO - 'use_talos_json': True, 01:44:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:44:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:44:31 INFO - 'work_dir': 'build'} 01:44:31 INFO - ##### 01:44:31 INFO - ##### Running clobber step. 01:44:31 INFO - ##### 01:44:31 INFO - Running pre-action listener: _resource_record_pre_action 01:44:31 INFO - Running main action method: clobber 01:44:31 INFO - rmtree: /builds/slave/test-pgo/build 01:44:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:44:32 INFO - Running post-action listener: _resource_record_post_action 01:44:32 INFO - ##### 01:44:32 INFO - ##### Running read-buildbot-config step. 01:44:32 INFO - ##### 01:44:32 INFO - Running pre-action listener: _resource_record_pre_action 01:44:32 INFO - Running main action method: read_buildbot_config 01:44:32 INFO - Using buildbot properties: 01:44:32 INFO - { 01:44:32 INFO - "project": "", 01:44:32 INFO - "product": "firefox", 01:44:32 INFO - "script_repo_revision": "production", 01:44:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:44:32 INFO - "repository": "", 01:44:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:44:32 INFO - "buildid": "20160107233010", 01:44:32 INFO - "pgo_build": "True", 01:44:32 INFO - "basedir": "/builds/slave/test-pgo", 01:44:32 INFO - "buildnumber": 193, 01:44:32 INFO - "slavename": "talos-linux64-ix-004", 01:44:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:44:32 INFO - "platform": "ubuntu64_hw", 01:44:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:44:32 INFO - "branch": "fx-team", 01:44:32 INFO - "repo_path": "integration/fx-team", 01:44:32 INFO - "revision": "ad7d6390e0f5e807e026384d9ef970b3bb24421c", 01:44:32 INFO - "stage_platform": "linux64-pgo", 01:44:32 INFO - "builduid": "6259bf93c39c4bf68e19a6afb4792aa2", 01:44:32 INFO - "slavebuilddir": "test" 01:44:32 INFO - } 01:44:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:44:32 INFO - Running post-action listener: _resource_record_post_action 01:44:32 INFO - ##### 01:44:32 INFO - ##### Running download-and-extract step. 01:44:32 INFO - ##### 01:44:32 INFO - Running pre-action listener: _resource_record_pre_action 01:44:32 INFO - Running main action method: download_and_extract 01:44:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:32 INFO - https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/test_packages.json 01:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/test_packages.json 01:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:44:42 INFO - Downloaded 1302 bytes. 01:44:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:44:42 INFO - Using the following test package requirements: 01:44:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:44:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:44:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'jsshell-linux-x86_64.zip'], 01:44:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:44:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:44:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:44:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:44:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:44:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:44:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:44:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:42 INFO - https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:44:47 INFO - Downloaded 24019636 bytes. 01:44:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 01:44:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:44:48 INFO - Return code: 0 01:44:48 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:44: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:44:48 INFO - https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:44:56 INFO - Downloaded 24019636 bytes. 01:44:56 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:44:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:44:56 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:44:57 INFO - Return code: 0 01:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:57 INFO - https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:44:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:44:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:44:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:33 INFO - Downloaded 11132285 bytes. 01:45:33 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:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:45:33 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:33 INFO - Return code: 0 01:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:33 INFO - https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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:35 INFO - Downloaded 55893204 bytes. 01:45:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:45:35 INFO - mkdir: /builds/slave/test-pgo/properties 01:45:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:45:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:45:35 INFO - Contents: 01:45:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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 - Running post-action listener: set_extra_try_arguments 01:45:35 INFO - ##### 01:45:35 INFO - ##### Running populate-webroot 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: populate_webroot 01:45:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:45:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:45:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:45:35 INFO - '--tppagecycles', 01:45:35 INFO - '7'], 01:45:35 INFO - 'tests': ['tsvgm']}}, 01:45:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:45:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:45:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:45:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:45:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'tests': ['damp', 'tps']}, 01:45:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['damp', 'tps']}, 01:45:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:45:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:45:35 INFO - 'other': {'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'other_l64': {'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'other_nol64': {'tests': ['a11yr', 01:45:35 INFO - 'ts_paint', 01:45:35 INFO - 'tpaint', 01:45:35 INFO - 'sessionrestore', 01:45:35 INFO - 'sessionrestore_no_auto_restore']}, 01:45:35 INFO - 'svgr': {'tests': ['tsvgx', 01:45:35 INFO - 'tsvgr_opacity', 01:45:35 INFO - 'tart', 01:45:35 INFO - 'tscrollx', 01:45:35 INFO - 'cart']}, 01:45:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['tsvgx', 01:45:35 INFO - 'tsvgr_opacity', 01:45:35 INFO - 'tart', 01:45:35 INFO - 'tscrollx', 01:45:35 INFO - 'cart']}, 01:45:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'tests': ['tp5o']}, 01:45:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'talos_options': ['--e10s'], 01:45:35 INFO - 'tests': ['tp5o']}, 01:45:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'talos_options': ['--xperf_path', 01:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:35 INFO - 'tests': ['tp5n']}, 01:45:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:45:35 INFO - 'talos_options': ['--e10s', 01:45:35 INFO - '--xperf_path', 01:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:45:35 INFO - 'tests': ['tp5n']}}, 01:45:35 INFO - 'talos.zip': {'path': '', 01:45:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:45:35 INFO - Running post-action listener: _resource_record_post_action 01:45:35 INFO - ##### 01:45:35 INFO - ##### Running create-virtualenv 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: create_virtualenv 01:45:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:45:35 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:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:45:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:45:35 INFO - Using real prefix '/usr' 01:45:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:45:36 INFO - Installing distribute.............................................................................................................................................................................................done. 01:45:38 INFO - Installing pip.................done. 01:45:38 INFO - Return code: 0 01:45:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:38 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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 01:45:38 INFO - 'HOME': '/home/cltbld', 01:45:38 INFO - 'LANG': 'en_US.UTF-8', 01:45:38 INFO - 'LANGUAGE': 'en_US:en', 01:45:38 INFO - 'LOGNAME': 'cltbld', 01:45:38 INFO - 'MAIL': '/var/mail/cltbld', 01:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:38 INFO - 'MOZ_NO_REMOTE': '1', 01:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:38 INFO - 'NO_EM_RESTART': '1', 01:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:38 INFO - 'SHELL': '/bin/bash', 01:45:38 INFO - 'SHLVL': '1', 01:45:38 INFO - 'TERM': 'linux', 01:45:38 INFO - 'TMOUT': '86400', 01:45:38 INFO - 'USER': 'cltbld', 01:45:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:38 INFO - '_': '/tools/buildbot/bin/python'} 01:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:38 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:38 INFO - Cleaning up... 01:45:38 INFO - Return code: 0 01:45:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:38 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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 01:45:38 INFO - 'HOME': '/home/cltbld', 01:45:38 INFO - 'LANG': 'en_US.UTF-8', 01:45:38 INFO - 'LANGUAGE': 'en_US:en', 01:45:38 INFO - 'LOGNAME': 'cltbld', 01:45:38 INFO - 'MAIL': '/var/mail/cltbld', 01:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:38 INFO - 'MOZ_NO_REMOTE': '1', 01:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:38 INFO - 'NO_EM_RESTART': '1', 01:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:38 INFO - 'SHELL': '/bin/bash', 01:45:38 INFO - 'SHLVL': '1', 01:45:38 INFO - 'TERM': 'linux', 01:45:38 INFO - 'TMOUT': '86400', 01:45:38 INFO - 'USER': 'cltbld', 01:45:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:38 INFO - '_': '/tools/buildbot/bin/python'} 01:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:38 INFO - Downloading/unpacking psutil>=0.7.1 01:45:38 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:38 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:38 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:38 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:38 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:38 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:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:45:40 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:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:40 INFO - Installing collected packages: psutil 01:45:40 INFO - Running setup.py install for psutil 01:45:40 INFO - building 'psutil._psutil_linux' extension 01:45:40 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:40 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:40 INFO - building 'psutil._psutil_posix' extension 01:45:40 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:40 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:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:45:40 INFO - Successfully installed psutil 01:45:40 INFO - Cleaning up... 01:45:41 INFO - Return code: 0 01:45:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:45:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:41 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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 01:45:41 INFO - 'HOME': '/home/cltbld', 01:45:41 INFO - 'LANG': 'en_US.UTF-8', 01:45:41 INFO - 'LANGUAGE': 'en_US:en', 01:45:41 INFO - 'LOGNAME': 'cltbld', 01:45:41 INFO - 'MAIL': '/var/mail/cltbld', 01:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:41 INFO - 'MOZ_NO_REMOTE': '1', 01:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:41 INFO - 'NO_EM_RESTART': '1', 01:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:41 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:41 INFO - 'SHELL': '/bin/bash', 01:45:41 INFO - 'SHLVL': '1', 01:45:41 INFO - 'TERM': 'linux', 01:45:41 INFO - 'TMOUT': '86400', 01:45:41 INFO - 'USER': 'cltbld', 01:45:41 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:41 INFO - '_': '/tools/buildbot/bin/python'} 01:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:45:41 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:41 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:41 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:41 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:41 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:41 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:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:45:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:45:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:45:42 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:42 INFO - Installing collected packages: mozsystemmonitor 01:45:42 INFO - Running setup.py install for mozsystemmonitor 01:45:43 INFO - Successfully installed mozsystemmonitor 01:45:43 INFO - Cleaning up... 01:45:43 INFO - Return code: 0 01:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:45:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:45:43 INFO - Using env: {'DISPLAY': ':0', 01:45:43 INFO - 'HOME': '/home/cltbld', 01:45:43 INFO - 'LANG': 'en_US.UTF-8', 01:45:43 INFO - 'LANGUAGE': 'en_US:en', 01:45:43 INFO - 'LOGNAME': 'cltbld', 01:45:43 INFO - 'MAIL': '/var/mail/cltbld', 01:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:43 INFO - 'MOZ_NO_REMOTE': '1', 01:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:43 INFO - 'NO_EM_RESTART': '1', 01:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:43 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:43 INFO - 'SHELL': '/bin/bash', 01:45:43 INFO - 'SHLVL': '1', 01:45:43 INFO - 'TERM': 'linux', 01:45:43 INFO - 'TMOUT': '86400', 01:45:43 INFO - 'USER': 'cltbld', 01:45:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:43 INFO - '_': '/tools/buildbot/bin/python'} 01:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:45 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:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:45 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:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:45 INFO - Downloading docopt-0.6.1.tar.gz 01:45:45 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:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:45 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:45 INFO - Running setup.py install for blobuploader 01:45:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:45:45 INFO - Running setup.py install for requests 01:45:46 INFO - Running setup.py install for docopt 01:45:46 INFO - Successfully installed blobuploader requests docopt 01:45:46 INFO - Cleaning up... 01:45:46 INFO - Return code: 0 01:45:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:45:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:46 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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 01:45:46 INFO - 'HOME': '/home/cltbld', 01:45:46 INFO - 'LANG': 'en_US.UTF-8', 01:45:46 INFO - 'LANGUAGE': 'en_US:en', 01:45:46 INFO - 'LOGNAME': 'cltbld', 01:45:46 INFO - 'MAIL': '/var/mail/cltbld', 01:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:46 INFO - 'MOZ_NO_REMOTE': '1', 01:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:46 INFO - 'NO_EM_RESTART': '1', 01:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:46 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:46 INFO - 'SHELL': '/bin/bash', 01:45:46 INFO - 'SHLVL': '1', 01:45:46 INFO - 'TERM': 'linux', 01:45:46 INFO - 'TMOUT': '86400', 01:45:46 INFO - 'USER': 'cltbld', 01:45:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:46 INFO - '_': '/tools/buildbot/bin/python'} 01:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:46 INFO - Running setup.py (path:/tmp/pip-zgyh5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:46 INFO - Running setup.py (path:/tmp/pip-caNsui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:46 INFO - Running setup.py (path:/tmp/pip-h66_xP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:46 INFO - Running setup.py (path:/tmp/pip-ppQHy_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:46 INFO - Running setup.py (path:/tmp/pip-HTfni4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:46 INFO - Running setup.py (path:/tmp/pip-aPPl53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:46 INFO - Running setup.py (path:/tmp/pip-SnOtDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:47 INFO - Running setup.py (path:/tmp/pip-CI2Zwz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:47 INFO - Running setup.py (path:/tmp/pip-ogoqei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:47 INFO - Running setup.py (path:/tmp/pip-zvCCOk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:47 INFO - Running setup.py (path:/tmp/pip-vFKGqd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:47 INFO - Running setup.py (path:/tmp/pip-JJGYU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:47 INFO - Running setup.py (path:/tmp/pip-mRozVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:47 INFO - Running setup.py (path:/tmp/pip-MOOLY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:47 INFO - Running setup.py (path:/tmp/pip-Rn1SEm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:47 INFO - Running setup.py (path:/tmp/pip-nyFo71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:47 INFO - Running setup.py (path:/tmp/pip-rlJaAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:47 INFO - Running setup.py install for manifestparser 01:45:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:45:47 INFO - Running setup.py install for mozcrash 01:45:47 INFO - Running setup.py install for mozdebug 01:45:48 INFO - Running setup.py install for mozdevice 01:45:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for mozfile 01:45:48 INFO - Running setup.py install for mozhttpd 01:45:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for mozinfo 01:45:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for mozInstall 01:45:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for mozleak 01:45:48 INFO - Running setup.py install for mozlog 01:45:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for moznetwork 01:45:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:45:48 INFO - Running setup.py install for mozprocess 01:45:49 INFO - Running setup.py install for mozprofile 01:45:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:45:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:45:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:45:49 INFO - Running setup.py install for mozrunner 01:45:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:45:49 INFO - Running setup.py install for mozscreenshot 01:45:49 INFO - Running setup.py install for moztest 01:45:49 INFO - Running setup.py install for mozversion 01:45:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:45:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:49 INFO - Cleaning up... 01:45:49 INFO - Return code: 0 01:45:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:49 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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 01:45:49 INFO - 'HOME': '/home/cltbld', 01:45:49 INFO - 'LANG': 'en_US.UTF-8', 01:45:49 INFO - 'LANGUAGE': 'en_US:en', 01:45:49 INFO - 'LOGNAME': 'cltbld', 01:45:49 INFO - 'MAIL': '/var/mail/cltbld', 01:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:49 INFO - 'MOZ_NO_REMOTE': '1', 01:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:49 INFO - 'NO_EM_RESTART': '1', 01:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:49 INFO - 'SHELL': '/bin/bash', 01:45:49 INFO - 'SHLVL': '1', 01:45:49 INFO - 'TERM': 'linux', 01:45:49 INFO - 'TMOUT': '86400', 01:45:49 INFO - 'USER': 'cltbld', 01:45:49 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:49 INFO - '_': '/tools/buildbot/bin/python'} 01:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:49 INFO - Running setup.py (path:/tmp/pip-C6_YmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:45:49 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:45:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:49 INFO - Running setup.py (path:/tmp/pip-swNzz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:45:49 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:45:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:49 INFO - Running setup.py (path:/tmp/pip-4KSJIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:45:49 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:45:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:49 INFO - Running setup.py (path:/tmp/pip-Na0p48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:50 INFO - Running setup.py (path:/tmp/pip-xY_ZhV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:50 INFO - Running setup.py (path:/tmp/pip-U0oFxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:50 INFO - Running setup.py (path:/tmp/pip-uhtLbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:50 INFO - Running setup.py (path:/tmp/pip-Jwl1CL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:50 INFO - Running setup.py (path:/tmp/pip-5mrB8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:50 INFO - Running setup.py (path:/tmp/pip-0tFzvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:50 INFO - Running setup.py (path:/tmp/pip-I4_PBl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:50 INFO - Running setup.py (path:/tmp/pip-u7Aihu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:50 INFO - Running setup.py (path:/tmp/pip-S5kKuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:50 INFO - Running setup.py (path:/tmp/pip-16jD2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:50 INFO - Running setup.py (path:/tmp/pip-M4Zj8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:50 INFO - Running setup.py (path:/tmp/pip-y5_ovA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:45:50 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:45:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:50 INFO - Running setup.py (path:/tmp/pip-x9buEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:45:50 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:45:50 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:45:50 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:45:51 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:45:51 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:45:51 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:45:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 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:52 INFO - Downloading blessings-1.5.1.tar.gz 01:45:52 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:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:45:52 INFO - Installing collected packages: blessings 01:45:52 INFO - Running setup.py install for blessings 01:45:52 INFO - Successfully installed blessings 01:45:52 INFO - Cleaning up... 01:45:52 INFO - Return code: 0 01:45:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:45:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:45:53 INFO - Reading from file tmpfile_stdout 01:45:53 INFO - Current package versions: 01:45:53 INFO - argparse == 1.2.1 01:45:53 INFO - blessings == 1.5.1 01:45:53 INFO - blobuploader == 1.2.4 01:45:53 INFO - docopt == 0.6.1 01:45:53 INFO - manifestparser == 1.1 01:45:53 INFO - mozInstall == 1.12 01:45:53 INFO - mozcrash == 0.16 01:45:53 INFO - mozdebug == 0.1 01:45:53 INFO - mozdevice == 0.47 01:45:53 INFO - mozfile == 1.2 01:45:53 INFO - mozhttpd == 0.7 01:45:53 INFO - mozinfo == 0.9 01:45:53 INFO - mozleak == 0.1 01:45:53 INFO - mozlog == 3.1 01:45:53 INFO - moznetwork == 0.27 01:45:53 INFO - mozprocess == 0.22 01:45:53 INFO - mozprofile == 0.28 01:45:53 INFO - mozrunner == 6.11 01:45:53 INFO - mozscreenshot == 0.1 01:45:53 INFO - mozsystemmonitor == 0.0 01:45:53 INFO - moztest == 0.7 01:45:53 INFO - mozversion == 1.4 01:45:53 INFO - psutil == 3.1.1 01:45:53 INFO - requests == 1.2.3 01:45:53 INFO - wsgiref == 0.1.2 01:45:53 INFO - Installing None 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', '-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 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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', '-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: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 -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: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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 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 - 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 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:45:53 INFO - Cleaning up... 01:45:53 INFO - Return code: 0 01:45:53 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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', 'jsonschema'] 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 jsonschema 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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 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 jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 01:45:55 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:45:55 INFO - Downloading/unpacking functools32 (from jsonschema) 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 functools32-3.2.3-2.tar.gz 01:45:55 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:45:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:45:55 INFO - warning: no files found matching '*.txt' 01:45:55 INFO - no previously-included directories found matching 'build' 01:45:55 INFO - no previously-included directories found matching 'dist' 01:45:55 INFO - no previously-included directories found matching '.git*' 01:45:55 INFO - Installing collected packages: jsonschema, functools32 01:45:55 INFO - Running setup.py install for functools32 01:45:55 INFO - warning: no files found matching '*.txt' 01:45:55 INFO - no previously-included directories found matching 'build' 01:45:55 INFO - no previously-included directories found matching 'dist' 01:45:55 INFO - no previously-included directories found matching '.git*' 01:45:55 INFO - Successfully installed jsonschema functools32 01:45:55 INFO - Cleaning up... 01:45:55 INFO - Return code: 0 01:45:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc942411f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1375630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', '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:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:45:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:45:55 INFO - Using env: {'DISPLAY': ':0', 01:45:55 INFO - 'HOME': '/home/cltbld', 01:45:55 INFO - 'LANG': 'en_US.UTF-8', 01:45:55 INFO - 'LANGUAGE': 'en_US:en', 01:45:55 INFO - 'LOGNAME': 'cltbld', 01:45:55 INFO - 'MAIL': '/var/mail/cltbld', 01:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:55 INFO - 'MOZ_NO_REMOTE': '1', 01:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:55 INFO - 'NO_EM_RESTART': '1', 01:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:45:55 INFO - 'SHELL': '/bin/bash', 01:45:55 INFO - 'SHLVL': '1', 01:45:55 INFO - 'TERM': 'linux', 01:45:55 INFO - 'TMOUT': '86400', 01:45:55 INFO - 'USER': 'cltbld', 01:45:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:55 INFO - '_': '/tools/buildbot/bin/python'} 01:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:55 INFO - Downloading/unpacking flake8 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:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:45:57 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:45:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:45:57 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:45:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:58 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:45:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:45:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:45:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:58 INFO - no previously-included directories found matching 'docs/_build' 01:45:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:45:58 INFO - Running setup.py install for pep8 01:45:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:58 INFO - no previously-included directories found matching 'docs/_build' 01:45:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:45:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:45:58 INFO - Cleaning up... 01:45:58 INFO - Return code: 0 01:45:58 INFO - Running post-action listener: _resource_record_post_action 01:45:58 INFO - Running post-action listener: _start_resource_monitoring 01:45:58 INFO - Starting resource monitoring. 01:45:58 INFO - ##### 01:45:58 INFO - ##### Running install step. 01:45:58 INFO - ##### 01:45:58 INFO - Running pre-action listener: _resource_record_pre_action 01:45:58 INFO - Running main action method: install 01:45:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:45:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:45:58 INFO - Reading from file tmpfile_stdout 01:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 01:45:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:45:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:45:58 INFO - Reading from file tmpfile_stdout 01:45:58 INFO - Output received: 01:45:58 INFO - Usage: mozinstall [options] installer 01:45:58 INFO - Options: 01:45:58 INFO - -h, --help show this help message and exit 01:45:58 INFO - -d DEST, --destination=DEST 01:45:58 INFO - Directory to install application into. [default: 01:45:58 INFO - "/builds/slave/test-pgo"] 01:45:58 INFO - --app=APP Application being installed. [default: firefox] 01:45:58 INFO - mkdir: /builds/slave/test-pgo/build/application 01:45:58 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:45:58 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:14 INFO - Reading from file tmpfile_stdout 01:46:14 INFO - Output received: 01:46:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:46:14 INFO - Running post-action listener: _resource_record_post_action 01:46:14 INFO - ##### 01:46:14 INFO - ##### Running run-tests step. 01:46:14 INFO - ##### 01:46:14 INFO - Running pre-action listener: _resource_record_pre_action 01:46:14 INFO - Running main action method: run_tests 01:46:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:46:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:46:14 INFO - Python 2.7.3 01:46:14 INFO - Return code: 0 01:46:14 INFO - grabbing minidump binary from tooltool 01:46:14 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:14 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 0x1406840>, '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 0x13736b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1373b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:46:14 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:14 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:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:46:15 INFO - Return code: 0 01:46:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:46:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:46:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:46:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:46:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:46:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:46:16 INFO - Return code: 0 01:46:16 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/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:16 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/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:16 INFO - Using env: {'DISPLAY': ':0', 01:46:16 INFO - 'HOME': '/home/cltbld', 01:46:16 INFO - 'LANG': 'en_US.UTF-8', 01:46:16 INFO - 'LANGUAGE': 'en_US:en', 01:46:16 INFO - 'LOGNAME': 'cltbld', 01:46:16 INFO - 'MAIL': '/var/mail/cltbld', 01:46:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:16 INFO - 'MOZ_NO_REMOTE': '1', 01:46:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:16 INFO - 'NO_EM_RESTART': '1', 01:46:16 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:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:16 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:46:16 INFO - 'SHELL': '/bin/bash', 01:46:16 INFO - 'SHLVL': '1', 01:46:16 INFO - 'TERM': 'linux', 01:46:16 INFO - 'TMOUT': '86400', 01:46:16 INFO - 'USER': 'cltbld', 01:46:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374', 01:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:16 INFO - '_': '/tools/buildbot/bin/python'} 01:46:16 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/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:16 INFO - mozversion application_buildid: 20160107233010 01:46:16 INFO - mozversion application_changeset: ad7d6390e0f5e807e026384d9ef970b3bb24421c 01:46:16 INFO - mozversion application_display_name: Nightly 01:46:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:46:16 INFO - mozversion application_name: Firefox 01:46:16 INFO - mozversion application_remotingname: firefox 01:46:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:46:16 INFO - mozversion application_vendor: Mozilla 01:46:16 INFO - mozversion application_version: 46.0a1 01:46:16 INFO - mozversion platform_buildid: 20160107233010 01:46:16 INFO - mozversion platform_changeset: ad7d6390e0f5e807e026384d9ef970b3bb24421c 01:46:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:46:16 INFO - mozversion platform_version: 46.0a1 01:46:16 INFO - using testdate: 1452246376 01:46:16 INFO - actual date: 1452246376 01:46:16 INFO - starting webserver on 'localhost:49976' 01:46:16 INFO - SUITE-START | Running 3 tests 01:46:16 INFO - TEST-START | dromaeo_css 01:46:16 INFO - operating with platform_type : linux_ 01:46:16 INFO - Initialising browser for dromaeo_css test... 01:46:16 INFO - TEST-INFO | started process 23594 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjFZXFQ/profile http://localhost:49976/getInfo.html) 01:46:20 INFO - PROCESS | 23594 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 01:46:21 INFO - PROCESS | 23594 | __metrics Screen width/height:1600/1200 01:46:21 INFO - PROCESS | 23594 | colorDepth:24 01:46:21 INFO - PROCESS | 23594 | Browser inner width/height: 1024/697 01:46:21 INFO - PROCESS | 23594 | __metrics 01:46:21 INFO - PROCESS | 23594 | 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:22 INFO - TEST-INFO | 23594: exit 0 01:46:22 INFO - Browser initialized. 01:46:22 INFO - Running cycle 1/1 for dromaeo_css test... 01:46:22 INFO - TEST-INFO | started process 23725 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjFZXFQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:46:34 INFO - PROCESS | 23725 | RSS: Main: 150880256 01:46:34 INFO - PROCESS | 23725 | 01:47:23 INFO - PROCESS | 23725 | 1452246443913 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:33 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49976/tests/dromaeo/cssquery-ext.html) 01:49:34 INFO - PROCESS | 23725 | RSS: Main: 157077504 01:49:34 INFO - PROCESS | 23725 | 01:52:36 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-ext.html (next: http://localhost:49976/tests/dromaeo/cssquery-jquery.html) 01:52:36 INFO - PROCESS | 23725 | RSS: Main: 152858624 01:52:36 INFO - PROCESS | 23725 | 01:55:38 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49976/tests/dromaeo/cssquery-mootools.html) 01:55:39 INFO - PROCESS | 23725 | RSS: Main: 153989120 01:55:39 INFO - PROCESS | 23725 | 01:58:40 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49976/tests/dromaeo/cssquery-prototype.html) 01:58:41 INFO - PROCESS | 23725 | RSS: Main: 152776704 01:58:41 INFO - PROCESS | 23725 | 02:01:43 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49976/tests/dromaeo/cssquery-yui.html) 02:01:44 INFO - PROCESS | 23725 | RSS: Main: 153632768 02:01:44 INFO - PROCESS | 23725 | 02:04:46 INFO - PROCESS | 23725 | Cycle 1(1): loaded http://localhost:49976/tests/dromaeo/cssquery-yui.html (next: http://localhost:49976/tests/dromaeo/cssquery-dojo.html) 02:04:47 INFO - PROCESS | 23725 | RSS: Main: 155627520 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | __start_tp_report 02:04:47 INFO - PROCESS | 23725 | _x_x_mozilla_page_load 02:04:47 INFO - PROCESS | 23725 | _x_x_mozilla_page_load_details 02:04:47 INFO - PROCESS | 23725 | |i|pagename|runs| 02:04:47 INFO - PROCESS | 23725 | |0;dojo.html;3165.8417079146043;3203.3273012667323;3227.01576019314;3247.058353077607;3253.0240927721693;5193.2989046478715;5370.489803468664;5388.595855310853;5417.160340147274;5446.019716451037;5277.577793776498;5303.018941495817;5383.138697808351;5496.038193316173;5497.422770609079;4827.22764357702;4932.7780249888665;4985.202367621181;5011.123053465647;5012.223105418648;4925.38432695913;4974.204127339626;4981.178105612569;5010.799568017275;5017.322661440695;4743.407074115736;4840.128776820171;4891.266310053485;4900.117978763821;5010.073136469765;4826.831060912887;4864.708117512961;4869.659123861331;4902.852914412538;4912.164931961575;4883.243097319921;4885.193942999401;4887.780049897728;4889.413270407538;4922.926156107661;5049.469805670388;5205.583553315726;5206.7917283308625;5242.344706911636;5266.34170728659;5727.856803579903;5780.855478613026;5817.970910145465;5841.415858414167;5855.209546711182;5798;5832.708364581754;5838.474537291621;5839.240898683186;5851.8537036574;5261.789528418859;5379.1393377059485;5453.590980676465;5461.863453413656;5470.972645136789;5867.471927526543;5929;5936.079907614327;5938.406159384113;6002.309734380515;5732.197492351074;5807.88384232313;5814.709264536841;5829.183914252008;5832.854178645568;5567.359753628303;5657.688827114466;5801.390853960358;5868.559858010666;5887.234659494238;5758.88482230353;5772;5789.53683705311;5810.970945145332;5841.795537156179;5786.189933409326;5813.331466881278;5814.680192589363;5834;5841.620294680833;4382.69321147523;4428.512863585003;4468.4414448193975;4486.573775491323;4500.347449619787;3926.4306675532457;3942.211557688474;3964.52425708911;3966.1076257841755;3977.8607748728655;5302.416734159239;5304.761285742151;5318.8936221276135;5320.866978325573;5370.516653501204;5715.5427565794635;5744.971275143681;5803.709814509258;5845.09401042839;5865.442782935615;5302.469753024667;5309.283246761715;5311.442298558673;5315;5323.1749078892835;4863.489333619989;4863.9513604864205;4869.366982292279;4886.755662216875;4910.263460480956;5921.644701317849;6020.458158765732;6047.848803779941;6048.153258543719;6050.42520960508;5764.798232061858;5808.7095645218415;5812.709364531672;5830;5868.823935281948;5978.133170690313;6002.429769171922;6005.759769609342;6016.097585362056;6047.606905551125;5740.885182296247;5746.741396637245;5777.653340799566;5798.85502862415;5814.534837212928;5706.828795136153;5744.741486633196;5804.738786754522;5809.767609295581;5841.474267315962;5674.2623458950075;5681.147827825859;5681.573881958787;5704.515116215168;5726.4273572642405;5583.330000399978;5652.293463317085;5669.971650141723;5681.488666020078;5698.458646428583;5536.91694624589;5624.493795558419;5643.407442218508;5674.120511320752;5705.7147142643535;5609.635373700697;5635;5654.575906806924;5683.8863222736145;5719.8570035749435;5491.560675145899;5582.720863956867;5594.02104631696;5601.831945041656;5608.046632072476 02:04:47 INFO - PROCESS | 23725 | |1;ext.html;527.8179028235257;529.4282175250729;535.3736128729383;560.3360018378224;560.4843543939577;34973.47539786905;35626.82186589063;35760.2847943041;35881.82059089704;36062.819685901566;38842.22315553694;39449.60550394502;39488;39541.20917581647;39547.604523954826;8323.91676083239;8494.575271236414;8508.361872859561;8524.659013639446;8527.914720852805;8308;8452.492850428964;8467.49195048299;8652.178043085896;8654.740357789276;8662.52356120413;8680.392372533925;8738.737837864874;8743.868841967344;8750.781230469225;8572.914270857305;8645.567721613957;8660.30717542595;8661.177188167114;8671.4363566368;8524.70163544273;8676.089010653854;8676.262517686004;8680.652773889036;8683.60923758426;38001.80999095015;38640.61359386426;38681.41977870334;38684.41973370402;38750.41874371887;2811.718828117172;3188.3942051010235;3247.3667634811222;3311.304626028537;3433.5879694436826;26042.218733437836;26228.82116984972;26268.343291417677;26273.868630656914;26569.070082547212;3648.72634552407;3899.064224586079;3976.622220889011;3990.1620659661507;4036.3945408188715;213867;216025;216249;216444;216696.91651541798;53909;54138.45861541413;54273;54279.72860135674;54330.72834635802;52976.20535691968;55056.449435505936;58861.41138588559;62018.37981620126;62282.688586557684;14996.47512337063;15042.548723538312;15155.166465844264;15180.026596542599;15192.240387980557;11863.88136118645;11879.10906681985;11882.88117118835;11902.226355287052;11913.404329783649;18694.53263668419;18780.624387512446;18781.436556903314;18899.90550047241;18902;7698.807529811687;7957.960210198912;7990.560519171385;8070.878936815952;8096.6761329547335;798.6126728536655;819.1603606303468;904.895936967244;924.7087167542203;932.7388331267256;30499;31456.213594659857;31520;31575.684243157735;31894.521582176287;992.538469611634;998.311165295958;1002.0630710285906;1005.8642083318658;1089.096050278267;15790.289436975363;16270;16743.413980510624;16888.746668799977;17063.146842657818;361165;365453;367691;368067;369543;52735.20897186545;53049;53066.46933530615;53097.2035419469;53151.20273195905;1309.2275557421167;1309.2471828698347;1317.3413293353324;1324.1988596898736;1339.9799003014962;28110;29276.414471710872;29417.705822941498;29532.852335738186;29846.10461686153;42709.14581708411;43402.782986084865;43430.56569434265;43444;43451.34822977595;293473;293504;293608;293692;294403;31292.217694557818;41689.1662166761;41869.1626167481;42258;42382.78808605937;36992.81503592465;37760.811195944945;38027.23945521019;38027.61972380241;38351.23297534089;34171.80398686034;34506.48240276448;34664.826675867465;34946;35144;34969.82515087408;34995.300093998485;35373.115672108404;35412.29175416426;35603;33548.89339213976;34037.82981085079;34318.14204644804;34626.48060279048;34631.82684086664;30920.381592368478;31746.841265793522;31765.68234317627;32135;33329.66670333266;24407.633885491377;24575.262742117764;24622.261332160066;25122.874385627954;25153.49693006093 02:04:47 INFO - PROCESS | 23725 | |2;jquery.html;353.47685425570154;356.68611621772834;357.55484421894744;359.5379936781233;364.46241793354807;10911.127109831214;11369;15950.601234969132;15957.68084638308;16604.252808623613;16692.998420094773;16830.66338673229;17851.732224016618;17960.281588736434;17989.91005044973;5509.035918714219;5752.36723960364;5781.364049954502;5783.074708046714;5795.014847475939;5515.310586176728;6029.909551356734;6038.69806509675;6041.728122234488;6045.063015232646;6027.156198132265;6051.636901785907;6237.282712488077;6560.606363618174;6567.507436942248;6376.202974628171;6425.646589437579;6622.337766223387;6908.447324214101;6959.791206263821;6426.903596446057;6659.7013582351465;6676.666166691646;6690;6691.3308669133185;21256.681149782766;21601.243956461447;21790.346289611338;22170.334889953327;22244;2015.1435639853005;2126.011404696808;2198.2525941180074;2231.698720672721;2246.9327069641954;13321.53374631893;13879.930600347034;13992.440302387893;14101.647458813612;14372.49696260626;1946.4549926020736;2012.154894944127;2017.3342796876996;2019.9899000504904;2052.98973505133;60806.69596651988;60910.69544652293;61957.6902115491;63649.68175159141;64266.3573364265;14669.119852808866;14788;14871;14920.70158596822;14945;22693.546129077327;22723.659145112837;22780.43048923757;22972.7702722974;23059.308220753403;8650.480971141751;8714.433561818461;8803.867941980876;8874.86687699685;8885.06706795777;7485.85028299431;7500.249975002456;7501.249875012455;7558.093028836574;7566.394688424913;7227.13274407064;7320.780376588711;7345.77962661121;7383.114026316769;7415.258474152542;1791.8297761712618;1857.294228193305;1873.6065426260639;3038.194878357237;3220.855838797739;780.2080887898787;884.9955300733714;987.7283746969641;987.8913319534845;995.348047029197;15342.309596068204;15392.615184620474;15435.15106669144;15633;15805.841941580667;881.4887365328094;891.9420237684529;897.8653202019618;996.4021587047713;998.6454808542862;9095.408798428081;9175;9236.445813251226;9322.927863295808;9534.618615255451;394617;402317;404777;406004;543041;68747.65626171837;69663.65168174228;70781.64609176922;73381.6330918342;75197;1092.322759888874;1124.5726623882872;1134.0813940708053;1142.3602782442026;1145.9255148415327;14550.41798328055;14967.925160374129;15097.576667381321;15187.924060379628;15245.456132040103;31597.684023159472;32635;33029.50455743118;34147.829260853534;34150.65849341475;43046.35430468483;43316.13367732691;43860.78069609631;43887.902802430195;45220.77389613031;7018.33325834045;7387.963060184665;7414.258574142543;7428.405727541892;7478;10175.236857235588;10342.638007669997;10840.403777792297;10993.725156871142;11218.326900386002;9336.439813611205;9429.764255893657;9581.712548623553;9594.808103838024;9631.566579504079;9336.579853906454;9369;9582.041795820362;10221.846672300071;10287.177025837766;9887.901120988985;10061.647842325483;10110.898891010997;10172.338797978107;10174.338667986558;7401.259874012556;7550;7558.13081495635;7574.5076570022775;7611.3530349920875;8321.750347489586;9621.51892405363;9705;9744.75638109053;9800.117989380704 02:04:47 INFO - PROCESS | 23725 | |3;mootools.html;1412.357377393286;1439.4314245872881;1520.498235582258;1720.655868826235;1723.345128851038;7082.433405327574;7178.820529486752;7286.81782955425;7315.12218533776;7360.815979600506;7333.449991250664;7345.485815992883;7401.444891633136;7408.444366672494;7424.591647459401;2198.758136604972;2219.1789038055863;2224.7219097612797;2225.321277010511;2228.131028898723;2200.6698995150696;2201.1635578480154;2245.932622021342;2253.7971582557566;2261.3555136786017;2124.4582631428966;2175.271284119814;2218.7115674962315;2233.4528040630066;2237.944051398712;2104.4633618427356;2110.7361579802523;2113.704081428586;2123.7557680866666;2135.2206444647745;2217.9112835486562;2229.565234779219;2243.170027089971;2253.0762387421078;2253.3240027991537;7358.558486490828;7363.226861179606;7387.556746595168;7432.7026918923175;7433.628318584103;4570.588647021751;4676.0647870426055;4686.08621318843;4691.835785747517;4722.102800467935;3093.443180227558;3116.56368108465;3120.8127512349106;3141.7172454479205;3150.243941454057;961.5865177973469;977.8924318324979;980.8577756225308;987.3532835992364;1010.7473131717071;9585.281103917234;9616.95191524052;9657.661981830672;9661.46861922594;9662.13040826322;3968.503937007874;3975.801209939549;4046.6560342371226;4048.716589838683;4110.77390743506;8071.677132914618;8081.0706768721175;8095.190480951857;8148.062972758209;8156.510609363457;4568.954310456919;4569.337446070368;4572.039871626929;4577.542245775462;4580.946382332082;4183.288840897055;4185.727927684691;4199.202151591188;4207.705460617727;4219.7046206765235;3359.1434184282853;3391.3217356528794;3435.4159792835276;3437.4671925851535;3437.9828100859336;1027.3784360461814;1028.0131074168733;1032.1381646325403;1033.266380869576;1045.5451878432907;967.8016006718606;969.0067680627413;1006.5671761142779;1030.5620111452602;1067.8451624514403;6920;6927.480438967098;6941.0629565009085;6972.37248647614;6998.440124790005;1073.7208325835184;1086.576235268246;1091.5033659684825;1092.382803715898;1108.6563165418745;5424.728763561806;5469.671819690831;5475.561955043587;5481.588880833874;5486.91769623456;8512.191341822518;8607.268382187583;8653.610587523577;8666.090060543678;8856.557172141367;8555.828883422297;8586.227239548345;8586.656533738706;8609.741707748777;8620.482771033758;6923.238443771181;7016.087908571853;7038.894416583756;7047.260037696071;7097.21930587635;6909.654517274217;6948.722051117898;6981.406580440719;6985.26654701249;7014.789556313319;7582.924170758221;7765.883511747215;7806.336461400844;7939.325157361689;8063.677452902053;7736.381089512713;7931.920680793118;7964.442489025944;8001.639926203218;8024.0772311184965;6458.483321334376;6463.515236357198;6522.119513865758;6526.902096468461;6535.934640653532;6997.195322537973;7074.646267686698;7088.397486213524;7102.538335008208;7128.928710713034;6755.729770809113;6779.389854913082;6812.829679258059;6920.93079069223;6954.617496037767;6786.219584747817;6787.117674702257;6789.660516974231;6819.942908849136;6850.0752398425575;6791.320867913169;6850.177978642595;6857.622830744357;6859;6864.073350097673;6089.665068421279;6163.19878415803;6166.568340216321;6167.074938759222;6174.320824709189;6219.813405597839;6282.905756413749;6290.685465726787;6292.433680968735;6295.779647712308 02:04:47 INFO - PROCESS | 23725 | |4;prototype.html;342.3290350912212;345.94118999770035;350.55129434324067;352.1513153300546;353.734698975768;6304.71628776705;6312.305646378901;6344.238691357038;6344.270408902978;6440.355964403558;6277.340879207686;6298.4646305064125;6314.715837787299;6321.304656487794;6322.0832979217985;4763.38076050113;4764.523547645243;4765.118453086173;4770.6422018348585;4771.952280477186;4776.68951518152;4777.163996300651;4780.043991201756;4786.449558300787;4789.3294938708605;4647;4742.170120228963;4743.715377077387;4744.478107408182;4750.809967601309;4707.05858828234;4713.198756211452;4718.221493453576;4719.834805781816;4727.243641017438;4078.449409329732;4121.443605113302;4129.2773764591075;4135.91728165435;4138.234426631053;5920.911186332209;5983.790567330166;5990.640561566276;5992.580519363646;5995.310539287994;5369.6509726867625;5464.890702185974;5487.2317875497465;5491.258680078218;5502.504774570308;6630.336966303379;6638.900416493708;6646.634435106067;6657.334266573353;6666.366695163952;4502.729836209805;4503.932441013388;4514.480834703985;4521.706089104197;4526.52471490492;6795.592264464099;6902.344277293649;6959.4432445404245;6971.442284617218;6990.4757143214465;4672.719636821802;4672.859814205579;4674.929876051862;4687.898343889184;4692.7653617319;4723.409573803275;4736.265878788793;4743.146233677902;4743.715377077387;4760.09558183944;5490.231367608538;5493.340799104133;5493.917591236134;5497.202905578669;5500.7524661390335;6492.383223593751;6707.429868461138;6708.161479815023;6722.596644201266;6746.291639377795;1643.7370020796616;1663.1767275198854;1675.0954484578435;1685.8988460692399;1690.6365131496786;1104.276698762312;1104.7735214281054;1109.517359948425;1110.722319420145;1128.6952522818792;6089.147519347206;6092.878142437126;6254.906176407358;6267.2165979252595;6278.277998030194;6754.797356079227;6766.627835469097;6816;6826.385625293748;6835.658217089225;6085.08723691441;6202.596831205957;6229.56393052482;6308.337624549448;6324.936750632527;3688.299223147647;3710.3135919854913;3713.350163721338;3718.5165928429133;3718.888433347004;7075.646217689095;7081.89377159343;7085.964570177116;7114.039604653409;7135.821604459827;6805.489588280899;6952.374286314256;6963.61700106499;6975.720971161097;7026.789196324118;7116.252793456716;7122.14534255903;7122.893156602655;7124.073870396815;7128.28717128283;6788.25329213796;6791.2190098139345;6797.864042719217;6835.769561478783;6840.41856442208;6599.967000164968;6662.866742665023;6713.160854893138;6734.73061077571;6750.493712971449;7053.012578239153;7081.46888983318;7088.716451342095;7089.468289878383;7100.467464940047;4608.170529304757;4628.39830821991;4643.071385722937;4643.582077613031;4647.976760116313;6742.190937087385;6806.965965170142;6814.386705196358;6821.2155602106395;6925.445964322741;6769.729210831511;6782.559133656297;6791.117154769849;6794.66026698673;6802.8639427212165;6747.224069231905;6750.493712971449;6754.831129221809;6773.866232136861;6775.119234499483;6500.772472963424;6632.1709786276715;6644;6664.866702666017;6676.699548520425;6786.796396108125;6799.388055075067;6821.3519715626935;6826.658667066726;6835.863282734218;6580.80257592273;6586.901196481961;6591.8022459324375;6591.868162636624;6600.570962887397 02:04:47 INFO - PROCESS | 23725 | |5;yui.html;692.3664846665301;696.6899729620319;709.5458906299967;738.9002484664569;782.7338704840357;12452.377381130942;12647.430865611046;12663.810042849365;12671.746565068705;12675.936620316897;12406.627801165956;12424.689382765435;12480.251184928911;12484.687882802911;12497.375131243447;746.6117618838201;761.7219714804085;762.6644276518342;764.0411283838774;765.3800421658447;639.7856717999452;648.915640966676;747.7831428885617;762.5767698927093;763.5456903142622;780.3016300411128;791.133708589094;791.4341246009102;793.8015496125969;794.0392125528118;776.3168411797639;787.1695361393728;787.9763607091796;788.0346575445092;789.0846617923211;580.0834681203688;580.1327016110941;584.0713265907185;585.5023230254293;586.0564491169214;12671.809922851164;12677.492900283978;12693.682657933534;12774;12803.871961280362;11021.889781102167;11387.430628468626;11401.258918170375;11544;11702.063834893188;9709.90290097097;9876.654317098866;9919.851202231972;10018.549165287579;10043.096121349114;3533.6466353364717;3568.6431356864364;3604.9279014419826;3673.0633688409284;3700.907477313062;42712.14575708468;42767.35848962268;43017.784911075556;43043.99999999969;43088.3536746949;8389.664413423518;8443.915560844436;8473.449225800303;8622.180892815173;8691.130886911258;16129.516114516584;16256.75614865778;16257.430989915532;16259.756103658454;16271.755923661154;6757.256701762803;6903.827404314832;6905.861882762417;6952.165740111219;6994.790156295319;3943.8619648312747;3995.522775878974;4006.8397264109108;4019.698522610816;4026.778527181033;2835.943281134366;2836.546152615572;2840.900568480093;2848.886044558236;2861.4706279337975;554.3680204566797;577.408156639448;582.2983305117324;584.1471451680594;591.8313280714975;510.36904755982965;517.5885171288759;527.2012900455812;594.8631814682648;661.566673828643;7610.657520411595;7964.960175199087;8533.829323413496;8534.914650853536;8995.820083598292;627.9372062793684;639.5746828359089;647.2007071266981;649.0880313160018;677.5223467455432;3852.4799152114106;3888.8055597220027;3984.5816189300285;4030.435738996543;4038.1116154445976;53943.73028134834;54301;54507.454925450234;54738;55201.72399138059;48803.511964879894;49355;49638.25542616864;49762.75118624384;50347;41893;44044.11911761811;44611.33083003757;44639.330410043876;45501.54498454973;7837.647305871364;7881.290683838482;7932.325752311118;7979.521228726295;8049.51702897828;32387;32685.18287042843;32751.508727368633;33300;33348;38735.806320968215;40813.795931020155;41717.16565668609;42034.579654203066;43214;9915.256355773201;9946.701598952042;9990.200783937413;10040.447775372424;10049.397036177852;10823.458827058457;10864.239503234698;10876.238663293494;10963.506642201279;11042.834357484484;11037.448127593749;11332.943335283271;11438.599649012578;11804.527818887149;11817.290962542274;11368.317900925971;11417.429128543707;11512.654620361403;11700.824487632523;11787.646370608896;10068.345557538736;10267.35631955693;10398.58405663765;10586.629467968583;10622.73443163927;8656.653733850575;8698.304135669257;8722.65109395617;8790.472571645721;9023.639054437748;8489.36329775257;8644.481331120152;8778.341624378325;9102.36031550843;9798.363106398061 02:04:47 INFO - PROCESS | 23725 | __end_tp_report 02:04:47 INFO - PROCESS | 23725 | __start_cc_report 02:04:47 INFO - PROCESS | 23725 | _x_x_mozilla_cycle_collect,309 02:04:47 INFO - PROCESS | 23725 | __end_cc_report 02:04:47 INFO - PROCESS | 23725 | __startTimestamp1452247487138__endTimestamp 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | ------- Summary: start ------- 02:04:47 INFO - PROCESS | 23725 | Number of tests: 6 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#0] dojo.html Cycles:165 Average:5370.99 Median:5608.05 stddev:610.92 (10.9%) stddev-sans-first:587.79 02:04:47 INFO - PROCESS | 23725 | Values: 3165.8 3203.3 3227.0 3247.1 3253.0 5193.3 5370.5 5388.6 5417.2 5446.0 5277.6 5303.0 5383.1 5496.0 5497.4 4827.2 4932.8 4985.2 5011.1 5012.2 4925.4 4974.2 4981.2 5010.8 5017.3 4743.4 4840.1 4891.3 4900.1 5010.1 4826.8 4864.7 4869.7 4902.9 4912.2 4883.2 4885.2 4887.8 4889.4 4922.9 5049.5 5205.6 5206.8 5242.3 5266.3 5727.9 5780.9 5818.0 5841.4 5855.2 5798.0 5832.7 5838.5 5839.2 5851.9 5261.8 5379.1 5453.6 5461.9 5471.0 5867.5 5929.0 5936.1 5938.4 6002.3 5732.2 5807.9 5814.7 5829.2 5832.9 5567.4 5657.7 5801.4 5868.6 5887.2 5758.9 5772.0 5789.5 5811.0 5841.8 5786.2 5813.3 5814.7 5834.0 5841.6 4382.7 4428.5 4468.4 4486.6 4500.3 3926.4 3942.2 3964.5 3966.1 3977.9 5302.4 5304.8 5318.9 5320.9 5370.5 5715.5 5745.0 5803.7 5845.1 5865.4 5302.5 5309.3 5311.4 5315.0 5323.2 4863.5 4864.0 4869.4 4886.8 4910.3 5921.6 6020.5 6047.8 6048.2 6050.4 5764.8 5808.7 5812.7 5830.0 5868.8 5978.1 6002.4 6005.8 6016.1 6047.6 5740.9 5746.7 5777.7 5798.9 5814.5 5706.8 5744.7 5804.7 5809.8 5841.5 5674.3 5681.1 5681.6 5704.5 5726.4 5583.3 5652.3 5670.0 5681.5 5698.5 5536.9 5624.5 5643.4 5674.1 5705.7 5609.6 5635.0 5654.6 5683.9 5719.9 5491.6 5582.7 5594.0 5601.8 5608.0 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#1] ext.html Cycles:180 Average:45779.29 Median:184550.86 stddev:78266.86 (42.4%) stddev-sans-first:78412.67 02:04:47 INFO - PROCESS | 23725 | Values: 527.8 529.4 535.4 560.3 560.5 34973.5 35626.8 35760.3 35881.8 36062.8 38842.2 39449.6 39488.0 39541.2 39547.6 8323.9 8494.6 8508.4 8524.7 8527.9 8308.0 8452.5 8467.5 8652.2 8654.7 8662.5 8680.4 8738.7 8743.9 8750.8 8572.9 8645.6 8660.3 8661.2 8671.4 8524.7 8676.1 8676.3 8680.7 8683.6 38001.8 38640.6 38681.4 38684.4 38750.4 2811.7 3188.4 3247.4 3311.3 3433.6 26042.2 26228.8 26268.3 26273.9 26569.1 3648.7 3899.1 3976.6 3990.2 4036.4 213867.0 216025.0 216249.0 216444.0 216696.9 53909.0 54138.5 54273.0 54279.7 54330.7 52976.2 55056.4 58861.4 62018.4 62282.7 14996.5 15042.5 15155.2 15180.0 15192.2 11863.9 11879.1 11882.9 11902.2 11913.4 18694.5 18780.6 18781.4 18899.9 18902.0 7698.8 7958.0 7990.6 8070.9 8096.7 798.6 819.2 904.9 924.7 932.7 30499.0 31456.2 31520.0 31575.7 31894.5 992.5 998.3 1002.1 1005.9 1089.1 15790.3 16270.0 16743.4 16888.7 17063.1 361165.0 365453.0 367691.0 368067.0 369543.0 52735.2 53049.0 53066.5 53097.2 53151.2 1309.2 1309.2 1317.3 1324.2 1340.0 28110.0 29276.4 29417.7 29532.9 29846.1 42709.1 43402.8 43430.6 43444.0 43451.3 293473.0 293504.0 293608.0 293692.0 294403.0 31292.2 41689.2 41869.2 42258.0 42382.8 36992.8 37760.8 38027.2 38027.6 38351.2 34171.8 34506.5 34664.8 34946.0 35144.0 34969.8 34995.3 35373.1 35412.3 35603.0 33548.9 34037.8 34318.1 34626.5 34631.8 30920.4 31746.8 31765.7 32135.0 33329.7 24407.6 24575.3 24622.3 25122.9 25153.5 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#2] jquery.html Cycles:180 Average:25416.99 Median:274275.02 stddev:71004.22 (25.9%) stddev-sans-first:71178.47 02:04:47 INFO - PROCESS | 23725 | Values: 353.5 356.7 357.6 359.5 364.5 10911.1 11369.0 15950.6 15957.7 16604.3 16693.0 16830.7 17851.7 17960.3 17989.9 5509.0 5752.4 5781.4 5783.1 5795.0 5515.3 6029.9 6038.7 6041.7 6045.1 6027.2 6051.6 6237.3 6560.6 6567.5 6376.2 6425.6 6622.3 6908.4 6959.8 6426.9 6659.7 6676.7 6690.0 6691.3 21256.7 21601.2 21790.3 22170.3 22244.0 2015.1 2126.0 2198.3 2231.7 2246.9 13321.5 13879.9 13992.4 14101.6 14372.5 1946.5 2012.2 2017.3 2020.0 2053.0 60806.7 60910.7 61957.7 63649.7 64266.4 14669.1 14788.0 14871.0 14920.7 14945.0 22693.5 22723.7 22780.4 22972.8 23059.3 8650.5 8714.4 8803.9 8874.9 8885.1 7485.9 7500.2 7501.2 7558.1 7566.4 7227.1 7320.8 7345.8 7383.1 7415.3 1791.8 1857.3 1873.6 3038.2 3220.9 780.2 885.0 987.7 987.9 995.3 15342.3 15392.6 15435.2 15633.0 15805.8 881.5 891.9 897.9 996.4 998.6 9095.4 9175.0 9236.4 9322.9 9534.6 394617.0 402317.0 404777.0 406004.0 543041.0 68747.7 69663.7 70781.6 73381.6 75197.0 1092.3 1124.6 1134.1 1142.4 1145.9 14550.4 14967.9 15097.6 15187.9 15245.5 31597.7 32635.0 33029.5 34147.8 34150.7 43046.4 43316.1 43860.8 43887.9 45220.8 7018.3 7388.0 7414.3 7428.4 7478.0 10175.2 10342.6 10840.4 10993.7 11218.3 9336.4 9429.8 9581.7 9594.8 9631.6 9336.6 9369.0 9582.0 10221.8 10287.2 9887.9 10061.6 10110.9 10172.3 10174.3 7401.3 7550.0 7558.1 7574.5 7611.4 8321.8 9621.5 9705.0 9744.8 9800.1 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#3] mootools.html Cycles:180 Average:5177.64 Median:6492.82 stddev:2605.77 (40.1%) stddev-sans-first:2597.71 02:04:47 INFO - PROCESS | 23725 | Values: 1412.4 1439.4 1520.5 1720.7 1723.3 7082.4 7178.8 7286.8 7315.1 7360.8 7333.4 7345.5 7401.4 7408.4 7424.6 2198.8 2219.2 2224.7 2225.3 2228.1 2200.7 2201.2 2245.9 2253.8 2261.4 2124.5 2175.3 2218.7 2233.5 2237.9 2104.5 2110.7 2113.7 2123.8 2135.2 2217.9 2229.6 2243.2 2253.1 2253.3 7358.6 7363.2 7387.6 7432.7 7433.6 4570.6 4676.1 4686.1 4691.8 4722.1 3093.4 3116.6 3120.8 3141.7 3150.2 961.6 977.9 980.9 987.4 1010.7 9585.3 9617.0 9657.7 9661.5 9662.1 3968.5 3975.8 4046.7 4048.7 4110.8 8071.7 8081.1 8095.2 8148.1 8156.5 4569.0 4569.3 4572.0 4577.5 4580.9 4183.3 4185.7 4199.2 4207.7 4219.7 3359.1 3391.3 3435.4 3437.5 3438.0 1027.4 1028.0 1032.1 1033.3 1045.5 967.8 969.0 1006.6 1030.6 1067.8 6920.0 6927.5 6941.1 6972.4 6998.4 1073.7 1086.6 1091.5 1092.4 1108.7 5424.7 5469.7 5475.6 5481.6 5486.9 8512.2 8607.3 8653.6 8666.1 8856.6 8555.8 8586.2 8586.7 8609.7 8620.5 6923.2 7016.1 7038.9 7047.3 7097.2 6909.7 6948.7 6981.4 6985.3 7014.8 7582.9 7765.9 7806.3 7939.3 8063.7 7736.4 7931.9 7964.4 8001.6 8024.1 6458.5 6463.5 6522.1 6526.9 6535.9 6997.2 7074.6 7088.4 7102.5 7128.9 6755.7 6779.4 6812.8 6920.9 6954.6 6786.2 6787.1 6789.7 6819.9 6850.1 6791.3 6850.2 6857.6 6859.0 6864.1 6089.7 6163.2 6166.6 6167.1 6174.3 6219.8 6282.9 6290.7 6292.4 6295.8 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#4] prototype.html Cycles:180 Average:5548.31 Median:6306.53 stddev:1687.05 (26.8%) stddev-sans-first:1645.90 02:04:47 INFO - PROCESS | 23725 | Values: 342.3 345.9 350.6 352.2 353.7 6304.7 6312.3 6344.2 6344.3 6440.4 6277.3 6298.5 6314.7 6321.3 6322.1 4763.4 4764.5 4765.1 4770.6 4772.0 4776.7 4777.2 4780.0 4786.4 4789.3 4647.0 4742.2 4743.7 4744.5 4750.8 4707.1 4713.2 4718.2 4719.8 4727.2 4078.4 4121.4 4129.3 4135.9 4138.2 5920.9 5983.8 5990.6 5992.6 5995.3 5369.7 5464.9 5487.2 5491.3 5502.5 6630.3 6638.9 6646.6 6657.3 6666.4 4502.7 4503.9 4514.5 4521.7 4526.5 6795.6 6902.3 6959.4 6971.4 6990.5 4672.7 4672.9 4674.9 4687.9 4692.8 4723.4 4736.3 4743.1 4743.7 4760.1 5490.2 5493.3 5493.9 5497.2 5500.8 6492.4 6707.4 6708.2 6722.6 6746.3 1643.7 1663.2 1675.1 1685.9 1690.6 1104.3 1104.8 1109.5 1110.7 1128.7 6089.1 6092.9 6254.9 6267.2 6278.3 6754.8 6766.6 6816.0 6826.4 6835.7 6085.1 6202.6 6229.6 6308.3 6324.9 3688.3 3710.3 3713.4 3718.5 3718.9 7075.6 7081.9 7086.0 7114.0 7135.8 6805.5 6952.4 6963.6 6975.7 7026.8 7116.3 7122.1 7122.9 7124.1 7128.3 6788.3 6791.2 6797.9 6835.8 6840.4 6600.0 6662.9 6713.2 6734.7 6750.5 7053.0 7081.5 7088.7 7089.5 7100.5 4608.2 4628.4 4643.1 4643.6 4648.0 6742.2 6807.0 6814.4 6821.2 6925.4 6769.7 6782.6 6791.1 6794.7 6802.9 6747.2 6750.5 6754.8 6773.9 6775.1 6500.8 6632.2 6644.0 6664.9 6676.7 6786.8 6799.4 6821.4 6826.7 6835.9 6580.8 6586.9 6591.8 6591.9 6600.6 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - PROCESS | 23725 | [#5] yui.html Cycles:180 Average:12918.76 Median:49496.63 stddev:14982.62 (30.3%) stddev-sans-first:14996.51 02:04:47 INFO - PROCESS | 23725 | Values: 692.4 696.7 709.5 738.9 782.7 12452.4 12647.4 12663.8 12671.7 12675.9 12406.6 12424.7 12480.3 12484.7 12497.4 746.6 761.7 762.7 764.0 765.4 639.8 648.9 747.8 762.6 763.5 780.3 791.1 791.4 793.8 794.0 776.3 787.2 788.0 788.0 789.1 580.1 580.1 584.1 585.5 586.1 12671.8 12677.5 12693.7 12774.0 12803.9 11021.9 11387.4 11401.3 11544.0 11702.1 9709.9 9876.7 9919.9 10018.5 10043.1 3533.6 3568.6 3604.9 3673.1 3700.9 42712.1 42767.4 43017.8 43044.0 43088.4 8389.7 8443.9 8473.4 8622.2 8691.1 16129.5 16256.8 16257.4 16259.8 16271.8 6757.3 6903.8 6905.9 6952.2 6994.8 3943.9 3995.5 4006.8 4019.7 4026.8 2835.9 2836.5 2840.9 2848.9 2861.5 554.4 577.4 582.3 584.1 591.8 510.4 517.6 527.2 594.9 661.6 7610.7 7965.0 8533.8 8534.9 8995.8 627.9 639.6 647.2 649.1 677.5 3852.5 3888.8 3984.6 4030.4 4038.1 53943.7 54301.0 54507.5 54738.0 55201.7 48803.5 49355.0 49638.3 49762.8 50347.0 41893.0 44044.1 44611.3 44639.3 45501.5 7837.6 7881.3 7932.3 7979.5 8049.5 32387.0 32685.2 32751.5 33300.0 33348.0 38735.8 40813.8 41717.2 42034.6 43214.0 9915.3 9946.7 9990.2 10040.4 10049.4 10823.5 10864.2 10876.2 10963.5 11042.8 11037.4 11332.9 11438.6 11804.5 11817.3 11368.3 11417.4 11512.7 11700.8 11787.6 10068.3 10267.4 10398.6 10586.6 10622.7 8656.7 8698.3 8722.7 8790.5 9023.6 8489.4 8644.5 8778.3 9102.4 9798.4 02:04:47 INFO - PROCESS | 23725 | -------- Summary: end -------- 02:04:47 INFO - PROCESS | 23725 | 02:04:47 INFO - TEST-INFO | 23725: exit 0 02:04:47 INFO - TEST-OK | dromaeo_css | took 1111640ms 02:04:47 INFO - TEST-START | kraken 02:04:47 INFO - operating with platform_type : linux_ 02:04:47 INFO - Initialising browser for kraken test... 02:04:47 INFO - TEST-INFO | started process 23967 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDWTzXI/profile http://localhost:49976/getInfo.html) 02:04:51 INFO - PROCESS | 23967 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 02:04:52 INFO - PROCESS | 23967 | __metrics Screen width/height:1600/1200 02:04:52 INFO - PROCESS | 23967 | colorDepth:24 02:04:52 INFO - PROCESS | 23967 | Browser inner width/height: 1024/697 02:04:52 INFO - PROCESS | 23967 | __metrics 02:04:52 INFO - PROCESS | 23967 | 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:04:53 INFO - TEST-INFO | 23967: exit 0 02:04:53 INFO - Browser initialized. 02:04:53 INFO - Running cycle 1/1 for kraken test... 02:04:53 INFO - TEST-INFO | started process 24087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDWTzXI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:05:05 INFO - PROCESS | 24087 | RSS: Main: 151080960 02:05:05 INFO - PROCESS | 24087 | 02:05:07 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49976/tests/kraken/driver.html?testName=audio-beat-detection) 02:05:08 INFO - PROCESS | 24087 | RSS: Main: 151572480 02:05:08 INFO - PROCESS | 24087 | 02:05:11 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49976/tests/kraken/driver.html?testName=audio-dft) 02:05:11 INFO - PROCESS | 24087 | RSS: Main: 150364160 02:05:11 INFO - PROCESS | 24087 | 02:05:14 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49976/tests/kraken/driver.html?testName=audio-fft) 02:05:15 INFO - PROCESS | 24087 | RSS: Main: 146325504 02:05:15 INFO - PROCESS | 24087 | 02:05:17 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49976/tests/kraken/driver.html?testName=audio-oscillator) 02:05:18 INFO - PROCESS | 24087 | RSS: Main: 147451904 02:05:18 INFO - PROCESS | 24087 | 02:05:20 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:05:20 INFO - PROCESS | 24087 | RSS: Main: 147521536 02:05:20 INFO - PROCESS | 24087 | 02:05:23 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49976/tests/kraken/driver.html?testName=imaging-darkroom) 02:05:24 INFO - PROCESS | 24087 | RSS: Main: 146370560 02:05:24 INFO - PROCESS | 24087 | 02:05:27 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49976/tests/kraken/driver.html?testName=imaging-desaturate) 02:05:28 INFO - PROCESS | 24087 | RSS: Main: 147451904 02:05:28 INFO - PROCESS | 24087 | 02:05:31 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49976/tests/kraken/driver.html?testName=json-parse-financial) 02:05:31 INFO - PROCESS | 24087 | RSS: Main: 147804160 02:05:31 INFO - PROCESS | 24087 | 02:05:33 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:33 INFO - PROCESS | 24087 | RSS: Main: 149155840 02:05:33 INFO - PROCESS | 24087 | 02:05:35 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:36 INFO - PROCESS | 24087 | RSS: Main: 149340160 02:05:36 INFO - PROCESS | 24087 | 02:05:38 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:39 INFO - PROCESS | 24087 | RSS: Main: 149946368 02:05:39 INFO - PROCESS | 24087 | 02:05:41 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:42 INFO - PROCESS | 24087 | RSS: Main: 147877888 02:05:42 INFO - PROCESS | 24087 | 02:05:44 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:45 INFO - PROCESS | 24087 | RSS: Main: 149254144 02:05:45 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | Cycle 1(1): loaded http://localhost:49976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49976/tests/kraken/driver.html?testName=ai-astar) 02:05:47 INFO - PROCESS | 24087 | RSS: Main: 148787200 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | __start_tp_report 02:05:47 INFO - PROCESS | 24087 | _x_x_mozilla_page_load 02:05:47 INFO - PROCESS | 24087 | _x_x_mozilla_page_load_details 02:05:47 INFO - PROCESS | 24087 | |i|pagename|runs| 02:05:47 INFO - PROCESS | 24087 | |0;ai-astar;114;105;111;111;113;121;111;112;111;113 02:05:47 INFO - PROCESS | 24087 | |1;audio-beat-detection;168;131;150;167;136;160;163;125;179;128 02:05:47 INFO - PROCESS | 24087 | |2;audio-dft;162;163;163;163;166;163;164;170;168;164 02:05:47 INFO - PROCESS | 24087 | |3;audio-fft;74;81;73;74;74;73;73;160;76;71 02:05:47 INFO - PROCESS | 24087 | |4;audio-oscillator;98;98;137;97;96;97;150;97;97;142 02:05:47 INFO - PROCESS | 24087 | |5;imaging-gaussian-blur;110;110;111;110;110;110;110;110;110;110 02:05:47 INFO - PROCESS | 24087 | |6;imaging-darkroom;147;146;146;146;148;147;147;146;147;147 02:05:47 INFO - PROCESS | 24087 | |7;imaging-desaturate;96;97;97;96;96;97;98;96;96;97 02:05:47 INFO - PROCESS | 24087 | |8;json-parse-financial;57;57;57;56;61;55;60;56;55;58 02:05:47 INFO - PROCESS | 24087 | |9;json-stringify-tinderbox;68;68;68;67;68;67;67;67;67;67 02:05:47 INFO - PROCESS | 24087 | |10;stanford-crypto-aes;87;88;89;88;88;96;90;90;86;85 02:05:47 INFO - PROCESS | 24087 | |11;stanford-crypto-ccm;119;130;119;121;122;124;126;123;122;121 02:05:47 INFO - PROCESS | 24087 | |12;stanford-crypto-pbkdf2;147;155;158;165;152;141;153;152;157;156 02:05:47 INFO - PROCESS | 24087 | |13;stanford-crypto-sha256-iterative;70;68;68;70;71;69;68;72;71;72 02:05:47 INFO - PROCESS | 24087 | __end_tp_report 02:05:47 INFO - PROCESS | 24087 | __start_cc_report 02:05:47 INFO - PROCESS | 24087 | _x_x_mozilla_cycle_collect,747 02:05:47 INFO - PROCESS | 24087 | __end_cc_report 02:05:47 INFO - PROCESS | 24087 | __startTimestamp1452247547341__endTimestamp 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | ------- Summary: start ------- 02:05:47 INFO - PROCESS | 24087 | Number of tests: 14 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.50 stddev:3.94 (3.5%) stddev-sans-first:4.12 02:05:47 INFO - PROCESS | 24087 | Values: 114.0 105.0 111.0 111.0 113.0 121.0 111.0 112.0 111.0 113.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:161.50 stddev:19.39 (12.0%) stddev-sans-first:19.53 02:05:47 INFO - PROCESS | 24087 | Values: 168.0 131.0 150.0 167.0 136.0 160.0 163.0 125.0 179.0 128.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.57 02:05:47 INFO - PROCESS | 24087 | Values: 162.0 163.0 163.0 163.0 166.0 163.0 164.0 170.0 168.0 164.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.00 stddev:27.22 (36.8%) stddev-sans-first:28.68 02:05:47 INFO - PROCESS | 24087 | Values: 74.0 81.0 73.0 74.0 74.0 73.0 73.0 160.0 76.0 71.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:22.37 (23.1%) stddev-sans-first:23.24 02:05:47 INFO - PROCESS | 24087 | Values: 98.0 98.0 137.0 97.0 96.0 97.0 150.0 97.0 97.0 142.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:05:47 INFO - PROCESS | 24087 | Values: 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:05:47 INFO - PROCESS | 24087 | Values: 147.0 146.0 146.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:05:47 INFO - PROCESS | 24087 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 98.0 96.0 96.0 97.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.99 (3.5%) stddev-sans-first:2.11 02:05:47 INFO - PROCESS | 24087 | Values: 57.0 57.0 57.0 56.0 61.0 55.0 60.0 56.0 55.0 58.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 02:05:47 INFO - PROCESS | 24087 | Values: 68.0 68.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 67.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.50 stddev:3.02 (3.4%) stddev-sans-first:3.14 02:05:47 INFO - PROCESS | 24087 | Values: 87.0 88.0 89.0 88.0 88.0 96.0 90.0 90.0 86.0 85.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:3.33 (2.7%) stddev-sans-first:3.26 02:05:47 INFO - PROCESS | 24087 | Values: 119.0 130.0 119.0 121.0 122.0 124.0 126.0 123.0 122.0 121.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:155.50 stddev:6.47 (4.2%) stddev-sans-first:6.40 02:05:47 INFO - PROCESS | 24087 | Values: 147.0 155.0 158.0 165.0 152.0 141.0 153.0 152.0 157.0 156.0 02:05:47 INFO - PROCESS | 24087 | 02:05:47 INFO - PROCESS | 24087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.60 (2.3%) stddev-sans-first:1.69 02:05:47 INFO - PROCESS | 24087 | Values: 70.0 68.0 68.0 70.0 71.0 69.0 68.0 72.0 71.0 72.0 02:05:47 INFO - PROCESS | 24087 | -------- Summary: end -------- 02:05:47 INFO - PROCESS | 24087 | 02:05:48 INFO - TEST-INFO | 24087: exit 0 02:05:48 INFO - TEST-OK | kraken | took 60407ms 02:05:48 INFO - TEST-START | v8_7 02:05:48 INFO - operating with platform_type : linux_ 02:05:48 INFO - Initialising browser for v8_7 test... 02:05:48 INFO - TEST-INFO | started process 24376 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSn3IYj/profile http://localhost:49976/getInfo.html) 02:05:52 INFO - PROCESS | 24376 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 02:05:52 INFO - PROCESS | 24376 | __metrics Screen width/height:1600/1200 02:05:52 INFO - PROCESS | 24376 | colorDepth:24 02:05:52 INFO - PROCESS | 24376 | Browser inner width/height: 1024/697 02:05:52 INFO - PROCESS | 24376 | __metrics 02:05:53 INFO - PROCESS | 24376 | 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:54 INFO - TEST-INFO | 24376: exit 0 02:05:54 INFO - Browser initialized. 02:05:54 INFO - Running cycle 1/1 for v8_7 test... 02:05:54 INFO - TEST-INFO | started process 24499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSn3IYj/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:05 INFO - PROCESS | 24499 | RSS: Main: 150499328 02:06:05 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | Cycle 1(1): loaded http://localhost:49976/tests/v8_7/run.html (next: http://localhost:49976/tests/v8_7/run.html) 02:06:28 INFO - PROCESS | 24499 | RSS: Main: 144543744 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | __start_tp_report 02:06:28 INFO - PROCESS | 24499 | _x_x_mozilla_page_load 02:06:28 INFO - PROCESS | 24499 | _x_x_mozilla_page_load_details 02:06:28 INFO - PROCESS | 24499 | |i|pagename|runs| 02:06:28 INFO - PROCESS | 24499 | |0;Richards;167.50418760469012 02:06:28 INFO - PROCESS | 24499 | |1;DeltaBlue;188.89308651303364 02:06:28 INFO - PROCESS | 24499 | |2;Encrypt;282.88543140028287 02:06:28 INFO - PROCESS | 24499 | |3;Decrypt;5223.958333333333 02:06:28 INFO - PROCESS | 24499 | |4;RayTrace;1076.4262648008612 02:06:28 INFO - PROCESS | 24499 | |5;Earley;747.0149253731344 02:06:28 INFO - PROCESS | 24499 | |6;Boyer;12493.827160493827 02:06:28 INFO - PROCESS | 24499 | |7;RegExp;40000 02:06:28 INFO - PROCESS | 24499 | |8;Splay;602.7727546714889 02:06:28 INFO - PROCESS | 24499 | |9;NavierStokes;4830.917874396136 02:06:28 INFO - PROCESS | 24499 | __end_tp_report 02:06:28 INFO - PROCESS | 24499 | __startTimestamp1452247588677__endTimestamp 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | ------- Summary: start ------- 02:06:28 INFO - PROCESS | 24499 | Number of tests: 10 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 167.5 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 188.9 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 282.9 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 5224.0 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 1076.4 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#5] Earley Cycles:1 Average:747.01 Median:747.01 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 747.0 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#6] Boyer Cycles:1 Average:12493.83 Median:12493.83 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 12493.8 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#7] RegExp Cycles:1 Average:40000.00 Median:40000.00 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 40000.0 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#8] Splay Cycles:1 Average:602.77 Median:602.77 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 602.8 02:06:28 INFO - PROCESS | 24499 | 02:06:28 INFO - PROCESS | 24499 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:06:28 INFO - PROCESS | 24499 | Values: 4830.9 02:06:28 INFO - PROCESS | 24499 | -------- Summary: end -------- 02:06:28 INFO - PROCESS | 24499 | 02:06:29 INFO - TEST-INFO | 24499: exit 0 02:06:29 INFO - TEST-OK | v8_7 | took 41359ms 02:06:29 INFO - SUITE-END | took 1213s 02:06:29 INFO - Completed test suite (00:20:13) 02:06:29 INFO - Working with test: dromaeo_css 02:06:29 INFO - Generating results file: dromaeo_css 02:06:29 INFO - Working with test: kraken 02:06:29 INFO - Generating results file: kraken 02:06:29 INFO - javascript benchmark 02:06:29 INFO - Working with test: v8_7 02:06:29 INFO - Generating results file: v8_7 02:06:29 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:06:29 INFO - process_Request line: dromaeo_css 6900.16 graph.html#tests=[[72,64,43]] 02:06:29 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:29 INFO - process_Request line: kraken 1534.20 graph.html#tests=[[232,64,43]] 02:06:29 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:06:29 INFO - process_Request line: v8_7 20241.62 graph.html#tests=[[230,64,43]] 02:06:29 INFO - RETURN: dromaeo_css: 6900.16 02:06:29 INFO - RETURN: kraken: 1534.20 02:06:29 INFO - RETURN: v8_7: 20241.62 02:06:29 INFO - javascript benchmark 02:06:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.8417079146043, 3203.3273012667323, 3227.01576019314, 3247.058353077607, 3253.0240927721693, 5193.2989046478715, 5370.489803468664, 5388.595855310853, 5417.160340147274, 5446.019716451037, 5277.577793776498, 5303.018941495817, 5383.138697808351, 5496.038193316173, 5497.422770609079, 4827.22764357702, 4932.7780249888665, 4985.202367621181, 5011.123053465647, 5012.223105418648, 4925.38432695913, 4974.204127339626, 4981.178105612569, 5010.799568017275, 5017.322661440695, 4743.407074115736, 4840.128776820171, 4891.266310053485, 4900.117978763821, 5010.073136469765, 4826.831060912887, 4864.708117512961, 4869.659123861331, 4902.852914412538, 4912.164931961575, 4883.243097319921, 4885.193942999401, 4887.780049897728, 4889.413270407538, 4922.926156107661, 5049.469805670388, 5205.583553315726, 5206.7917283308625, 5242.344706911636, 5266.34170728659, 5727.856803579903, 5780.855478613026, 5817.970910145465, 5841.415858414167, 5855.209546711182, 5798.0, 5832.708364581754, 5838.474537291621, 5839.240898683186, 5851.8537036574, 5261.789528418859, 5379.1393377059485, 5453.590980676465, 5461.863453413656, 5470.972645136789, 5867.471927526543, 5929.0, 5936.079907614327, 5938.406159384113, 6002.309734380515, 5732.197492351074, 5807.88384232313, 5814.709264536841, 5829.183914252008, 5832.854178645568, 5567.359753628303, 5657.688827114466, 5801.390853960358, 5868.559858010666, 5887.234659494238, 5758.88482230353, 5772.0, 5789.53683705311, 5810.970945145332, 5841.795537156179, 5786.189933409326, 5813.331466881278, 5814.680192589363, 5834.0, 5841.620294680833, 4382.69321147523, 4428.512863585003, 4468.4414448193975, 4486.573775491323, 4500.347449619787, 3926.4306675532457, 3942.211557688474, 3964.52425708911, 3966.1076257841755, 3977.8607748728655, 5302.416734159239, 5304.761285742151, 5318.8936221276135, 5320.866978325573, 5370.516653501204, 5715.5427565794635, 5744.971275143681, 5803.709814509258, 5845.09401042839, 5865.442782935615, 5302.469753024667, 5309.283246761715, 5311.442298558673, 5315.0, 5323.1749078892835, 4863.489333619989, 4863.9513604864205, 4869.366982292279, 4886.755662216875, 4910.263460480956, 5921.644701317849, 6020.458158765732, 6047.848803779941, 6048.153258543719, 6050.42520960508, 5764.798232061858, 5808.7095645218415, 5812.709364531672, 5830.0, 5868.823935281948, 5978.133170690313, 6002.429769171922, 6005.759769609342, 6016.097585362056, 6047.606905551125, 5740.885182296247, 5746.741396637245, 5777.653340799566, 5798.85502862415, 5814.534837212928, 5706.828795136153, 5744.741486633196, 5804.738786754522, 5809.767609295581, 5841.474267315962, 5674.2623458950075, 5681.147827825859, 5681.573881958787, 5704.515116215168, 5726.4273572642405, 5583.330000399978, 5652.293463317085, 5669.971650141723, 5681.488666020078, 5698.458646428583, 5536.91694624589, 5624.493795558419, 5643.407442218508, 5674.120511320752, 5705.7147142643535, 5609.635373700697, 5635.0, 5654.575906806924, 5683.8863222736145, 5719.8570035749435, 5491.560675145899, 5582.720863956867, 5594.02104631696, 5601.831945041656, 5608.046632072476], "unit": "score", "name": "dojo.html", "value": 5330.566268514313}, {"lowerIsBetter": false, "replicates": [527.8179028235257, 529.4282175250729, 535.3736128729383, 560.3360018378224, 560.4843543939577, 34973.47539786905, 35626.82186589063, 35760.2847943041, 35881.82059089704, 36062.819685901566, 38842.22315553694, 39449.60550394502, 39488.0, 39541.20917581647, 39547.604523954826, 8323.91676083239, 8494.575271236414, 8508.361872859561, 8524.659013639446, 8527.914720852805, 8308.0, 8452.492850428964, 8467.49195048299, 8652.178043085896, 8654.740357789276, 8662.52356120413, 8680.392372533925, 8738.737837864874, 8743.868841967344, 8750.781230469225, 8572.914270857305, 8645.567721613957, 8660.30717542595, 8661.177188167114, 8671.4363566368, 8524.70163544273, 8676.089010653854, 8676.262517686004, 8680.652773889036, 8683.60923758426, 38001.80999095015, 38640.61359386426, 38681.41977870334, 38684.41973370402, 38750.41874371887, 2811.718828117172, 3188.3942051010235, 3247.3667634811222, 3311.304626028537, 3433.5879694436826, 26042.218733437836, 26228.82116984972, 26268.343291417677, 26273.868630656914, 26569.070082547212, 3648.72634552407, 3899.064224586079, 3976.622220889011, 3990.1620659661507, 4036.3945408188715, 213867.0, 216025.0, 216249.0, 216444.0, 216696.91651541798, 53909.0, 54138.45861541413, 54273.0, 54279.72860135674, 54330.72834635802, 52976.20535691968, 55056.449435505936, 58861.41138588559, 62018.37981620126, 62282.688586557684, 14996.47512337063, 15042.548723538312, 15155.166465844264, 15180.026596542599, 15192.240387980557, 11863.88136118645, 11879.10906681985, 11882.88117118835, 11902.226355287052, 11913.404329783649, 18694.53263668419, 18780.624387512446, 18781.436556903314, 18899.90550047241, 18902.0, 7698.807529811687, 7957.960210198912, 7990.560519171385, 8070.878936815952, 8096.6761329547335, 798.6126728536655, 819.1603606303468, 904.895936967244, 924.7087167542203, 932.7388331267256, 30499.0, 31456.213594659857, 31520.0, 31575.684243157735, 31894.521582176287, 992.538469611634, 998.311165295958, 1002.0630710285906, 1005.8642083318658, 1089.096050278267, 15790.289436975363, 16270.0, 16743.413980510624, 16888.746668799977, 17063.146842657818, 361165.0, 365453.0, 367691.0, 368067.0, 369543.0, 52735.20897186545, 53049.0, 53066.46933530615, 53097.2035419469, 53151.20273195905, 1309.2275557421167, 1309.2471828698347, 1317.3413293353324, 1324.1988596898736, 1339.9799003014962, 28110.0, 29276.414471710872, 29417.705822941498, 29532.852335738186, 29846.10461686153, 42709.14581708411, 43402.782986084865, 43430.56569434265, 43444.0, 43451.34822977595, 293473.0, 293504.0, 293608.0, 293692.0, 294403.0, 31292.217694557818, 41689.1662166761, 41869.1626167481, 42258.0, 42382.78808605937, 36992.81503592465, 37760.811195944945, 38027.23945521019, 38027.61972380241, 38351.23297534089, 34171.80398686034, 34506.48240276448, 34664.826675867465, 34946.0, 35144.0, 34969.82515087408, 34995.300093998485, 35373.115672108404, 35412.29175416426, 35603.0, 33548.89339213976, 34037.82981085079, 34318.14204644804, 34626.48060279048, 34631.82684086664, 30920.381592368478, 31746.841265793522, 31765.68234317627, 32135.0, 33329.66670333266, 24407.633885491377, 24575.262742117764, 24622.261332160066, 25122.874385627954, 25153.49693006093], "unit": "score", "name": "ext.html", "value": 18088.43494989101}, {"lowerIsBetter": false, "replicates": [353.47685425570154, 356.68611621772834, 357.55484421894744, 359.5379936781233, 364.46241793354807, 10911.127109831214, 11369.0, 15950.601234969132, 15957.68084638308, 16604.252808623613, 16692.998420094773, 16830.66338673229, 17851.732224016618, 17960.281588736434, 17989.91005044973, 5509.035918714219, 5752.36723960364, 5781.364049954502, 5783.074708046714, 5795.014847475939, 5515.310586176728, 6029.909551356734, 6038.69806509675, 6041.728122234488, 6045.063015232646, 6027.156198132265, 6051.636901785907, 6237.282712488077, 6560.606363618174, 6567.507436942248, 6376.202974628171, 6425.646589437579, 6622.337766223387, 6908.447324214101, 6959.791206263821, 6426.903596446057, 6659.7013582351465, 6676.666166691646, 6690.0, 6691.3308669133185, 21256.681149782766, 21601.243956461447, 21790.346289611338, 22170.334889953327, 22244.0, 2015.1435639853005, 2126.011404696808, 2198.2525941180074, 2231.698720672721, 2246.9327069641954, 13321.53374631893, 13879.930600347034, 13992.440302387893, 14101.647458813612, 14372.49696260626, 1946.4549926020736, 2012.154894944127, 2017.3342796876996, 2019.9899000504904, 2052.98973505133, 60806.69596651988, 60910.69544652293, 61957.6902115491, 63649.68175159141, 64266.3573364265, 14669.119852808866, 14788.0, 14871.0, 14920.70158596822, 14945.0, 22693.546129077327, 22723.659145112837, 22780.43048923757, 22972.7702722974, 23059.308220753403, 8650.480971141751, 8714.433561818461, 8803.867941980876, 8874.86687699685, 8885.06706795777, 7485.85028299431, 7500.249975002456, 7501.249875012455, 7558.093028836574, 7566.394688424913, 7227.13274407064, 7320.780376588711, 7345.77962661121, 7383.114026316769, 7415.258474152542, 1791.8297761712618, 1857.294228193305, 1873.6065426260639, 3038.194878357237, 3220.855838797739, 780.2080887898787, 884.9955300733714, 987.7283746969641, 987.8913319534845, 995.348047029197, 15342.309596068204, 15392.615184620474, 15435.15106669144, 15633.0, 15805.841941580667, 881.4887365328094, 891.9420237684529, 897.8653202019618, 996.4021587047713, 998.6454808542862, 9095.408798428081, 9175.0, 9236.445813251226, 9322.927863295808, 9534.618615255451, 394617.0, 402317.0, 404777.0, 406004.0, 543041.0, 68747.65626171837, 69663.65168174228, 70781.64609176922, 73381.6330918342, 75197.0, 1092.322759888874, 1124.5726623882872, 1134.0813940708053, 1142.3602782442026, 1145.9255148415327, 14550.41798328055, 14967.925160374129, 15097.576667381321, 15187.924060379628, 15245.456132040103, 31597.684023159472, 32635.0, 33029.50455743118, 34147.829260853534, 34150.65849341475, 43046.35430468483, 43316.13367732691, 43860.78069609631, 43887.902802430195, 45220.77389613031, 7018.33325834045, 7387.963060184665, 7414.258574142543, 7428.405727541892, 7478.0, 10175.236857235588, 10342.638007669997, 10840.403777792297, 10993.725156871142, 11218.326900386002, 9336.439813611205, 9429.764255893657, 9581.712548623553, 9594.808103838024, 9631.566579504079, 9336.579853906454, 9369.0, 9582.041795820362, 10221.846672300071, 10287.177025837766, 9887.901120988985, 10061.647842325483, 10110.898891010997, 10172.338797978107, 10174.338667986558, 7401.259874012556, 7550.0, 7558.13081495635, 7574.5076570022775, 7611.3530349920875, 8321.750347489586, 9621.51892405363, 9705.0, 9744.75638109053, 9800.117989380704], "unit": "score", "name": "jquery.html", "value": 8868.30064047575}, {"lowerIsBetter": false, "replicates": [1412.357377393286, 1439.4314245872881, 1520.498235582258, 1720.655868826235, 1723.345128851038, 7082.433405327574, 7178.820529486752, 7286.81782955425, 7315.12218533776, 7360.815979600506, 7333.449991250664, 7345.485815992883, 7401.444891633136, 7408.444366672494, 7424.591647459401, 2198.758136604972, 2219.1789038055863, 2224.7219097612797, 2225.321277010511, 2228.131028898723, 2200.6698995150696, 2201.1635578480154, 2245.932622021342, 2253.7971582557566, 2261.3555136786017, 2124.4582631428966, 2175.271284119814, 2218.7115674962315, 2233.4528040630066, 2237.944051398712, 2104.4633618427356, 2110.7361579802523, 2113.704081428586, 2123.7557680866666, 2135.2206444647745, 2217.9112835486562, 2229.565234779219, 2243.170027089971, 2253.0762387421078, 2253.3240027991537, 7358.558486490828, 7363.226861179606, 7387.556746595168, 7432.7026918923175, 7433.628318584103, 4570.588647021751, 4676.0647870426055, 4686.08621318843, 4691.835785747517, 4722.102800467935, 3093.443180227558, 3116.56368108465, 3120.8127512349106, 3141.7172454479205, 3150.243941454057, 961.5865177973469, 977.8924318324979, 980.8577756225308, 987.3532835992364, 1010.7473131717071, 9585.281103917234, 9616.95191524052, 9657.661981830672, 9661.46861922594, 9662.13040826322, 3968.503937007874, 3975.801209939549, 4046.6560342371226, 4048.716589838683, 4110.77390743506, 8071.677132914618, 8081.0706768721175, 8095.190480951857, 8148.062972758209, 8156.510609363457, 4568.954310456919, 4569.337446070368, 4572.039871626929, 4577.542245775462, 4580.946382332082, 4183.288840897055, 4185.727927684691, 4199.202151591188, 4207.705460617727, 4219.7046206765235, 3359.1434184282853, 3391.3217356528794, 3435.4159792835276, 3437.4671925851535, 3437.9828100859336, 1027.3784360461814, 1028.0131074168733, 1032.1381646325403, 1033.266380869576, 1045.5451878432907, 967.8016006718606, 969.0067680627413, 1006.5671761142779, 1030.5620111452602, 1067.8451624514403, 6920.0, 6927.480438967098, 6941.0629565009085, 6972.37248647614, 6998.440124790005, 1073.7208325835184, 1086.576235268246, 1091.5033659684825, 1092.382803715898, 1108.6563165418745, 5424.728763561806, 5469.671819690831, 5475.561955043587, 5481.588880833874, 5486.91769623456, 8512.191341822518, 8607.268382187583, 8653.610587523577, 8666.090060543678, 8856.557172141367, 8555.828883422297, 8586.227239548345, 8586.656533738706, 8609.741707748777, 8620.482771033758, 6923.238443771181, 7016.087908571853, 7038.894416583756, 7047.260037696071, 7097.21930587635, 6909.654517274217, 6948.722051117898, 6981.406580440719, 6985.26654701249, 7014.789556313319, 7582.924170758221, 7765.883511747215, 7806.336461400844, 7939.325157361689, 8063.677452902053, 7736.381089512713, 7931.920680793118, 7964.442489025944, 8001.639926203218, 8024.0772311184965, 6458.483321334376, 6463.515236357198, 6522.119513865758, 6526.902096468461, 6535.934640653532, 6997.195322537973, 7074.646267686698, 7088.397486213524, 7102.538335008208, 7128.928710713034, 6755.729770809113, 6779.389854913082, 6812.829679258059, 6920.93079069223, 6954.617496037767, 6786.219584747817, 6787.117674702257, 6789.660516974231, 6819.942908849136, 6850.0752398425575, 6791.320867913169, 6850.177978642595, 6857.622830744357, 6859.0, 6864.073350097673, 6089.665068421279, 6163.19878415803, 6166.568340216321, 6167.074938759222, 6174.320824709189, 6219.813405597839, 6282.905756413749, 6290.685465726787, 6292.433680968735, 6295.779647712308], "unit": "score", "name": "mootools.html", "value": 4276.7892868986155}, {"lowerIsBetter": false, "replicates": [342.3290350912212, 345.94118999770035, 350.55129434324067, 352.1513153300546, 353.734698975768, 6304.71628776705, 6312.305646378901, 6344.238691357038, 6344.270408902978, 6440.355964403558, 6277.340879207686, 6298.4646305064125, 6314.715837787299, 6321.304656487794, 6322.0832979217985, 4763.38076050113, 4764.523547645243, 4765.118453086173, 4770.6422018348585, 4771.952280477186, 4776.68951518152, 4777.163996300651, 4780.043991201756, 4786.449558300787, 4789.3294938708605, 4647.0, 4742.170120228963, 4743.715377077387, 4744.478107408182, 4750.809967601309, 4707.05858828234, 4713.198756211452, 4718.221493453576, 4719.834805781816, 4727.243641017438, 4078.449409329732, 4121.443605113302, 4129.2773764591075, 4135.91728165435, 4138.234426631053, 5920.911186332209, 5983.790567330166, 5990.640561566276, 5992.580519363646, 5995.310539287994, 5369.6509726867625, 5464.890702185974, 5487.2317875497465, 5491.258680078218, 5502.504774570308, 6630.336966303379, 6638.900416493708, 6646.634435106067, 6657.334266573353, 6666.366695163952, 4502.729836209805, 4503.932441013388, 4514.480834703985, 4521.706089104197, 4526.52471490492, 6795.592264464099, 6902.344277293649, 6959.4432445404245, 6971.442284617218, 6990.4757143214465, 4672.719636821802, 4672.859814205579, 4674.929876051862, 4687.898343889184, 4692.7653617319, 4723.409573803275, 4736.265878788793, 4743.146233677902, 4743.715377077387, 4760.09558183944, 5490.231367608538, 5493.340799104133, 5493.917591236134, 5497.202905578669, 5500.7524661390335, 6492.383223593751, 6707.429868461138, 6708.161479815023, 6722.596644201266, 6746.291639377795, 1643.7370020796616, 1663.1767275198854, 1675.0954484578435, 1685.8988460692399, 1690.6365131496786, 1104.276698762312, 1104.7735214281054, 1109.517359948425, 1110.722319420145, 1128.6952522818792, 6089.147519347206, 6092.878142437126, 6254.906176407358, 6267.2165979252595, 6278.277998030194, 6754.797356079227, 6766.627835469097, 6816.0, 6826.385625293748, 6835.658217089225, 6085.08723691441, 6202.596831205957, 6229.56393052482, 6308.337624549448, 6324.936750632527, 3688.299223147647, 3710.3135919854913, 3713.350163721338, 3718.5165928429133, 3718.888433347004, 7075.646217689095, 7081.89377159343, 7085.964570177116, 7114.039604653409, 7135.821604459827, 6805.489588280899, 6952.374286314256, 6963.61700106499, 6975.720971161097, 7026.789196324118, 7116.252793456716, 7122.14534255903, 7122.893156602655, 7124.073870396815, 7128.28717128283, 6788.25329213796, 6791.2190098139345, 6797.864042719217, 6835.769561478783, 6840.41856442208, 6599.967000164968, 6662.866742665023, 6713.160854893138, 6734.73061077571, 6750.493712971449, 7053.012578239153, 7081.46888983318, 7088.716451342095, 7089.468289878383, 7100.467464940047, 4608.170529304757, 4628.39830821991, 4643.071385722937, 4643.582077613031, 4647.976760116313, 6742.190937087385, 6806.965965170142, 6814.386705196358, 6821.2155602106395, 6925.445964322741, 6769.729210831511, 6782.559133656297, 6791.117154769849, 6794.66026698673, 6802.8639427212165, 6747.224069231905, 6750.493712971449, 6754.831129221809, 6773.866232136861, 6775.119234499483, 6500.772472963424, 6632.1709786276715, 6644.0, 6664.866702666017, 6676.699548520425, 6786.796396108125, 6799.388055075067, 6821.3519715626935, 6826.658667066726, 6835.863282734218, 6580.80257592273, 6586.901196481961, 6591.8022459324375, 6591.868162636624, 6600.570962887397], "unit": "score", "name": "prototype.html", "value": 4998.002727385894}, {"lowerIsBetter": false, "replicates": [692.3664846665301, 696.6899729620319, 709.5458906299967, 738.9002484664569, 782.7338704840357, 12452.377381130942, 12647.430865611046, 12663.810042849365, 12671.746565068705, 12675.936620316897, 12406.627801165956, 12424.689382765435, 12480.251184928911, 12484.687882802911, 12497.375131243447, 746.6117618838201, 761.7219714804085, 762.6644276518342, 764.0411283838774, 765.3800421658447, 639.7856717999452, 648.915640966676, 747.7831428885617, 762.5767698927093, 763.5456903142622, 780.3016300411128, 791.133708589094, 791.4341246009102, 793.8015496125969, 794.0392125528118, 776.3168411797639, 787.1695361393728, 787.9763607091796, 788.0346575445092, 789.0846617923211, 580.0834681203688, 580.1327016110941, 584.0713265907185, 585.5023230254293, 586.0564491169214, 12671.809922851164, 12677.492900283978, 12693.682657933534, 12774.0, 12803.871961280362, 11021.889781102167, 11387.430628468626, 11401.258918170375, 11544.0, 11702.063834893188, 9709.90290097097, 9876.654317098866, 9919.851202231972, 10018.549165287579, 10043.096121349114, 3533.6466353364717, 3568.6431356864364, 3604.9279014419826, 3673.0633688409284, 3700.907477313062, 42712.14575708468, 42767.35848962268, 43017.784911075556, 43043.99999999969, 43088.3536746949, 8389.664413423518, 8443.915560844436, 8473.449225800303, 8622.180892815173, 8691.130886911258, 16129.516114516584, 16256.75614865778, 16257.430989915532, 16259.756103658454, 16271.755923661154, 6757.256701762803, 6903.827404314832, 6905.861882762417, 6952.165740111219, 6994.790156295319, 3943.8619648312747, 3995.522775878974, 4006.8397264109108, 4019.698522610816, 4026.778527181033, 2835.943281134366, 2836.546152615572, 2840.900568480093, 2848.886044558236, 2861.4706279337975, 554.3680204566797, 577.408156639448, 582.2983305117324, 584.1471451680594, 591.8313280714975, 510.36904755982965, 517.5885171288759, 527.2012900455812, 594.8631814682648, 661.566673828643, 7610.657520411595, 7964.960175199087, 8533.829323413496, 8534.914650853536, 8995.820083598292, 627.9372062793684, 639.5746828359089, 647.2007071266981, 649.0880313160018, 677.5223467455432, 3852.4799152114106, 3888.8055597220027, 3984.5816189300285, 4030.435738996543, 4038.1116154445976, 53943.73028134834, 54301.0, 54507.454925450234, 54738.0, 55201.72399138059, 48803.511964879894, 49355.0, 49638.25542616864, 49762.75118624384, 50347.0, 41893.0, 44044.11911761811, 44611.33083003757, 44639.330410043876, 45501.54498454973, 7837.647305871364, 7881.290683838482, 7932.325752311118, 7979.521228726295, 8049.51702897828, 32387.0, 32685.18287042843, 32751.508727368633, 33300.0, 33348.0, 38735.806320968215, 40813.795931020155, 41717.16565668609, 42034.579654203066, 43214.0, 9915.256355773201, 9946.701598952042, 9990.200783937413, 10040.447775372424, 10049.397036177852, 10823.458827058457, 10864.239503234698, 10876.238663293494, 10963.506642201279, 11042.834357484484, 11037.448127593749, 11332.943335283271, 11438.599649012578, 11804.527818887149, 11817.290962542274, 11368.317900925971, 11417.429128543707, 11512.654620361403, 11700.824487632523, 11787.646370608896, 10068.345557538736, 10267.35631955693, 10398.58405663765, 10586.629467968583, 10622.73443163927, 8656.653733850575, 8698.304135669257, 8722.65109395617, 8790.472571645721, 9023.639054437748, 8489.36329775257, 8644.481331120152, 8778.341624378325, 9102.36031550843, 9798.363106398061], "unit": "score", "name": "yui.html", "value": 5904.5588211406775}], "name": "dromaeo_css", "value": 6900.160986296748}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 111.0, 111.0, 113.0, 121.0, 111.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [168.0, 131.0, 150.0, 167.0, 136.0, 160.0, 163.0, 125.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 166.0, 163.0, 164.0, 170.0, 168.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [74.0, 81.0, 73.0, 74.0, 74.0, 73.0, 73.0, 160.0, 76.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 137.0, 97.0, 96.0, 97.0, 150.0, 97.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 98.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 61.0, 55.0, 60.0, 56.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 89.0, 88.0, 88.0, 96.0, 90.0, 90.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.7}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 119.0, 121.0, 122.0, 124.0, 126.0, 123.0, 122.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [147.0, 155.0, 158.0, 165.0, 152.0, 141.0, 153.0, 152.0, 157.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 70.0, 71.0, 69.0, 68.0, 72.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1534.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [747.0149253731344], "unit": "score", "name": "Earley", "value": 892.168251748252}, {"lowerIsBetter": false, "replicates": [12493.827160493827], "unit": "score", "name": "Boyer", "value": 53.34338241106715}, {"lowerIsBetter": false, "replicates": [40000.0], "unit": "score", "name": "RegExp", "value": 22.774625}, {"lowerIsBetter": false, "replicates": [602.7727546714889], "unit": "score", "name": "Splay", "value": 135.19356900000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20241.623523671675}]} 02:06:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20241.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1534.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6900.16"}}} 02:06:29 INFO - Return code: 0 02:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:06:29 INFO - # TBPL SUCCESS # 02:06:29 INFO - Running post-action listener: _resource_record_post_action 02:06:29 INFO - Running post-run listener: _resource_record_post_run 02:06:30 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 414674944; Read time: 0; Write time: 347416 02:06:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 96702464; Read time: 0; Write time: 87712 02:06:31 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 317972480; Read time: 0; Write time: 259704 02:06:31 INFO - Running post-run listener: _upload_blobber_files 02:06:31 INFO - Blob upload gear active. 02:06:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:06:31 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:31 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:31 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:31 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:33 INFO - (blobuploader) - INFO - Done attempting. 02:06:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:06:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:06:33 INFO - (blobuploader) - INFO - Done attempting. 02:06:33 INFO - (blobuploader) - INFO - Iteration through files over. 02:06:33 INFO - Return code: 0 02:06:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:06:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:06:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be3eb328b4728953f5bd93ebfd4d6cd0c556d273be1d150f469c68163378c15395b36e37ee633b535bcfd3cc3bb4067724cad7f124fff271cf3e68c15887aac3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e8d20c152e11e3c7234f5a7f6b102ee7545437e691d597c670211c6506f32621ca15a95b65f87f2817cc0b00b45de0c2bad818c62eaf3e01af8372ee7063d09"} 02:06:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:06:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:06:33 INFO - Contents: 02:06:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be3eb328b4728953f5bd93ebfd4d6cd0c556d273be1d150f469c68163378c15395b36e37ee633b535bcfd3cc3bb4067724cad7f124fff271cf3e68c15887aac3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e8d20c152e11e3c7234f5a7f6b102ee7545437e691d597c670211c6506f32621ca15a95b65f87f2817cc0b00b45de0c2bad818c62eaf3e01af8372ee7063d09"} 02:06:33 INFO - Copying logs to upload dir... 02:06:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1322.147300 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-01-08 02:06:33.328221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 02:06:33.331403) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 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/be3eb328b4728953f5bd93ebfd4d6cd0c556d273be1d150f469c68163378c15395b36e37ee633b535bcfd3cc3bb4067724cad7f124fff271cf3e68c15887aac3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e8d20c152e11e3c7234f5a7f6b102ee7545437e691d597c670211c6506f32621ca15a95b65f87f2817cc0b00b45de0c2bad818c62eaf3e01af8372ee7063d09"} build_url:https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011568 build_url: 'https://queue.taskcluster.net/v1/task/PSyFq1LOQMyQsfuT5CG2lQ/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/be3eb328b4728953f5bd93ebfd4d6cd0c556d273be1d150f469c68163378c15395b36e37ee633b535bcfd3cc3bb4067724cad7f124fff271cf3e68c15887aac3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e8d20c152e11e3c7234f5a7f6b102ee7545437e691d597c670211c6506f32621ca15a95b65f87f2817cc0b00b45de0c2bad818c62eaf3e01af8372ee7063d09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 02:06:33.355906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 02:06:33.356236) ========= 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=c6927cf182745ad25b1d38b9000001fe-1452244955.226179-608404374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 02:06:33.442336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 02:06:33.442667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 02:06:33.442957) ========= ========= Total master_lag: 0.25 =========