builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1452636264.59 results: success (0) buildid: 20160112113026 builduid: 95025c8a052444e092d5f7e8b340a2a7 revision: 743089edf783c1fd6f174d25cd474c87bce91061 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.591120) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.591667) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.592254) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006461 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.617434) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.617751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.657732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.658038) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.731636) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.731940) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.732334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.732665) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 14:04:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 219M=0s 2016-01-12 14:04:25 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095265 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.841877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.842200) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.891831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:24.892200) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 743089edf783c1fd6f174d25cd474c87bce91061 --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 743089edf783c1fd6f174d25cd474c87bce91061 --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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 14:04:25,424 truncating revision to first 12 chars 2016-01-12 14:04:25,424 Setting DEBUG logging. 2016-01-12 14:04:25,424 attempt 1/10 2016-01-12 14:04:25,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/743089edf783?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 14:04:25,991 unpacking tar archive at: fx-team-743089edf783/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:25.779888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:25.780199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:25.787276) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:25.787553) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 14:04:25.787946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-12 14:04:25.788246) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:26 INFO - MultiFileLogger online at 20160112 14:04:26 in /builds/slave/test-pgo 14:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:04:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:04:26 INFO - {'append_to_log': False, 14:04:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:04:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:04:26 INFO - 'branch': 'Fx-Team', 14:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:26 INFO - 'config_files': ('talos/linux_config.py',), 14:04:26 INFO - 'default_actions': ('clobber', 14:04:26 INFO - 'read-buildbot-config', 14:04:26 INFO - 'download-and-extract', 14:04:26 INFO - 'populate-webroot', 14:04:26 INFO - 'create-virtualenv', 14:04:26 INFO - 'install', 14:04:26 INFO - 'run-tests'), 14:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:26 INFO - 'download_minidump_stackwalk': True, 14:04:26 INFO - 'download_symbols': 'ondemand', 14:04:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:26 INFO - 'installer_path': 'installer.exe', 14:04:26 INFO - 'log_level': 'info', 14:04:26 INFO - 'log_name': 'talos', 14:04:26 INFO - 'log_to_console': True, 14:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:26 INFO - 'opt_config_files': (), 14:04:26 INFO - 'pip_index': False, 14:04:26 INFO - 'sps_profile': False, 14:04:26 INFO - 'sps_profile_interval': 0, 14:04:26 INFO - 'suite': 'dromaeojs', 14:04:26 INFO - 'system_bits': '32', 14:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:26 INFO - 'title': 'talos-linux64-ix-035', 14:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:26 INFO - 'use_talos_json': True, 14:04:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:26 INFO - 'work_dir': 'build'} 14:04:26 INFO - ##### 14:04:26 INFO - ##### Running clobber step. 14:04:26 INFO - ##### 14:04:26 INFO - Running pre-action listener: _resource_record_pre_action 14:04:26 INFO - Running main action method: clobber 14:04:26 INFO - rmtree: /builds/slave/test-pgo/build 14:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:04:26 INFO - Running post-action listener: _resource_record_post_action 14:04:26 INFO - ##### 14:04:26 INFO - ##### Running read-buildbot-config step. 14:04:26 INFO - ##### 14:04:26 INFO - Running pre-action listener: _resource_record_pre_action 14:04:26 INFO - Running main action method: read_buildbot_config 14:04:26 INFO - Using buildbot properties: 14:04:26 INFO - { 14:04:26 INFO - "project": "", 14:04:26 INFO - "product": "firefox", 14:04:26 INFO - "script_repo_revision": "production", 14:04:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:04:26 INFO - "repository": "", 14:04:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:04:26 INFO - "buildid": "20160112113026", 14:04:26 INFO - "pgo_build": "True", 14:04:26 INFO - "basedir": "/builds/slave/test-pgo", 14:04:26 INFO - "buildnumber": 892, 14:04:26 INFO - "slavename": "talos-linux64-ix-035", 14:04:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:04:26 INFO - "platform": "ubuntu64_hw", 14:04:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:04:26 INFO - "branch": "fx-team", 14:04:26 INFO - "repo_path": "integration/fx-team", 14:04:26 INFO - "revision": "743089edf783c1fd6f174d25cd474c87bce91061", 14:04:26 INFO - "stage_platform": "linux64-pgo", 14:04:26 INFO - "builduid": "95025c8a052444e092d5f7e8b340a2a7", 14:04:26 INFO - "slavebuilddir": "test" 14:04:26 INFO - } 14:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:04:26 INFO - Running post-action listener: _resource_record_post_action 14:04:26 INFO - ##### 14:04:26 INFO - ##### Running download-and-extract step. 14:04:26 INFO - ##### 14:04:26 INFO - Running pre-action listener: _resource_record_pre_action 14:04:26 INFO - Running main action method: download_and_extract 14:04:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:26 INFO - https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/test_packages.json 14:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/test_packages.json 14:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:04:38 INFO - Downloaded 1302 bytes. 14:04:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:04:38 INFO - Using the following test package requirements: 14:04:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'jsshell-linux-x86_64.zip'], 14:04:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04: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')]} 14:04:38 INFO - https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:49 INFO - Downloaded 24027161 bytes. 14:04:49 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 14:04:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:49 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 14:04:50 INFO - Return code: 0 14:04:50 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 14:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:50 INFO - https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:53 INFO - Downloaded 24027161 bytes. 14:04:53 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 14:04:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:53 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 14:04:54 INFO - Return code: 0 14:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:54 INFO - https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:57 INFO - Downloaded 11132285 bytes. 14:04:57 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 14:04:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:57 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 14:04:57 INFO - Return code: 0 14:04: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')]} 14:04:57 INFO - https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/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 14:05:00 INFO - Downloaded 55741812 bytes. 14:05:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:05:00 INFO - mkdir: /builds/slave/test-pgo/properties 14:05:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:05:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:05:00 INFO - Contents: 14:05:00 INFO - build_url:https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:05:00 INFO - Running post-action listener: _resource_record_post_action 14:05:00 INFO - Running post-action listener: set_extra_try_arguments 14:05:00 INFO - ##### 14:05:00 INFO - ##### Running populate-webroot step. 14:05:00 INFO - ##### 14:05:00 INFO - Running pre-action listener: _resource_record_pre_action 14:05:00 INFO - Running main action method: populate_webroot 14:05:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:00 INFO - '--tppagecycles', 14:05:00 INFO - '7'], 14:05:00 INFO - 'tests': ['tsvgm']}}, 14:05:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:05:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:05:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:05:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'tests': ['damp', 'tps']}, 14:05:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['damp', 'tps']}, 14:05:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:05:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:00 INFO - 'other': {'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'other_l64': {'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'other_nol64': {'tests': ['a11yr', 14:05:00 INFO - 'ts_paint', 14:05:00 INFO - 'tpaint', 14:05:00 INFO - 'sessionrestore', 14:05:00 INFO - 'sessionrestore_no_auto_restore']}, 14:05:00 INFO - 'svgr': {'tests': ['tsvgx', 14:05:00 INFO - 'tsvgr_opacity', 14:05:00 INFO - 'tart', 14:05:00 INFO - 'tscrollx', 14:05:00 INFO - 'cart']}, 14:05:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['tsvgx', 14:05:00 INFO - 'tsvgr_opacity', 14:05:00 INFO - 'tart', 14:05:00 INFO - 'tscrollx', 14:05:00 INFO - 'cart']}, 14:05:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'tests': ['tp5o']}, 14:05:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'talos_options': ['--e10s'], 14:05:00 INFO - 'tests': ['tp5o']}, 14:05:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'talos_options': ['--xperf_path', 14:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:00 INFO - 'tests': ['tp5n']}, 14:05:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:00 INFO - 'talos_options': ['--e10s', 14:05:00 INFO - '--xperf_path', 14:05:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:00 INFO - 'tests': ['tp5n']}}, 14:05:00 INFO - 'talos.zip': {'path': '', 14:05:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:00 INFO - Running post-action listener: _resource_record_post_action 14:05:00 INFO - ##### 14:05:00 INFO - ##### Running create-virtualenv step. 14:05:00 INFO - ##### 14:05:00 INFO - Running pre-action listener: _resource_record_pre_action 14:05:00 INFO - Running main action method: create_virtualenv 14:05:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:05:00 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 14:05:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:05:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:00 INFO - Using real prefix '/usr' 14:05:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:03 INFO - Installing pip.................done. 14:05:03 INFO - Return code: 0 14:05:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:05:03 INFO - Using env: {'DISPLAY': ':0', 14:05:03 INFO - 'HOME': '/home/cltbld', 14:05:03 INFO - 'LANG': 'en_US.UTF-8', 14:05:03 INFO - 'LANGUAGE': 'en_US:en', 14:05:03 INFO - 'LOGNAME': 'cltbld', 14:05:03 INFO - 'MAIL': '/var/mail/cltbld', 14:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:03 INFO - 'MOZ_NO_REMOTE': '1', 14:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:03 INFO - 'NO_EM_RESTART': '1', 14:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:03 INFO - 'SHELL': '/bin/bash', 14:05:03 INFO - 'SHLVL': '1', 14:05:03 INFO - 'TERM': 'linux', 14:05:03 INFO - 'TMOUT': '86400', 14:05:03 INFO - 'USER': 'cltbld', 14:05:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:03 INFO - '_': '/tools/buildbot/bin/python'} 14:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:03 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 14:05:03 INFO - Cleaning up... 14:05:03 INFO - Return code: 0 14:05:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:05:03 INFO - Using env: {'DISPLAY': ':0', 14:05:03 INFO - 'HOME': '/home/cltbld', 14:05:03 INFO - 'LANG': 'en_US.UTF-8', 14:05:03 INFO - 'LANGUAGE': 'en_US:en', 14:05:03 INFO - 'LOGNAME': 'cltbld', 14:05:03 INFO - 'MAIL': '/var/mail/cltbld', 14:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:03 INFO - 'MOZ_NO_REMOTE': '1', 14:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:03 INFO - 'NO_EM_RESTART': '1', 14:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:03 INFO - 'SHELL': '/bin/bash', 14:05:03 INFO - 'SHLVL': '1', 14:05:03 INFO - 'TERM': 'linux', 14:05:03 INFO - 'TMOUT': '86400', 14:05:03 INFO - 'USER': 'cltbld', 14:05:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:03 INFO - '_': '/tools/buildbot/bin/python'} 14:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:03 INFO - Downloading/unpacking psutil>=0.7.1 14:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:05:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:05 INFO - Installing collected packages: psutil 14:05:05 INFO - Running setup.py install for psutil 14:05:05 INFO - building 'psutil._psutil_linux' extension 14:05:05 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 14:05:05 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 14:05:05 INFO - building 'psutil._psutil_posix' extension 14:05:05 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 14:05:05 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 14:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:05 INFO - Successfully installed psutil 14:05:05 INFO - Cleaning up... 14:05:05 INFO - Return code: 0 14:05:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:05 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 14:05:05 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 14:05:05 INFO - Using env: {'DISPLAY': ':0', 14:05:05 INFO - 'HOME': '/home/cltbld', 14:05:05 INFO - 'LANG': 'en_US.UTF-8', 14:05:05 INFO - 'LANGUAGE': 'en_US:en', 14:05:05 INFO - 'LOGNAME': 'cltbld', 14:05:05 INFO - 'MAIL': '/var/mail/cltbld', 14:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:05 INFO - 'MOZ_NO_REMOTE': '1', 14:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:05 INFO - 'NO_EM_RESTART': '1', 14:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:05 INFO - 'SHELL': '/bin/bash', 14:05:05 INFO - 'SHLVL': '1', 14:05:05 INFO - 'TERM': 'linux', 14:05:05 INFO - 'TMOUT': '86400', 14:05:05 INFO - 'USER': 'cltbld', 14:05:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:05 INFO - '_': '/tools/buildbot/bin/python'} 14:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:05:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:05:07 INFO - Installing collected packages: mozsystemmonitor 14:05:07 INFO - Running setup.py install for mozsystemmonitor 14:05:08 INFO - Successfully installed mozsystemmonitor 14:05:08 INFO - Cleaning up... 14:05:08 INFO - Return code: 0 14:05:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:05:08 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')]} 14:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:08 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')]} 14:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:08 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:08 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 14:05:08 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 14:05:08 INFO - Using env: {'DISPLAY': ':0', 14:05:08 INFO - 'HOME': '/home/cltbld', 14:05:08 INFO - 'LANG': 'en_US.UTF-8', 14:05:08 INFO - 'LANGUAGE': 'en_US:en', 14:05:08 INFO - 'LOGNAME': 'cltbld', 14:05:08 INFO - 'MAIL': '/var/mail/cltbld', 14:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:08 INFO - 'MOZ_NO_REMOTE': '1', 14:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:08 INFO - 'NO_EM_RESTART': '1', 14:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:08 INFO - 'SHELL': '/bin/bash', 14:05:08 INFO - 'SHLVL': '1', 14:05:08 INFO - 'TERM': 'linux', 14:05:08 INFO - 'TMOUT': '86400', 14:05:08 INFO - 'USER': 'cltbld', 14:05:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:08 INFO - '_': '/tools/buildbot/bin/python'} 14:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:05:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:05:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:05:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 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 14:05:10 INFO - Downloading docopt-0.6.1.tar.gz 14:05:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:05:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:10 INFO - Running setup.py install for blobuploader 14:05:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:05:10 INFO - Running setup.py install for requests 14:05:11 INFO - Running setup.py install for docopt 14:05:11 INFO - Successfully installed blobuploader requests docopt 14:05:11 INFO - Cleaning up... 14:05:11 INFO - Return code: 0 14:05:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:11 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:11 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 14:05:11 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 14:05:11 INFO - Using env: {'DISPLAY': ':0', 14:05:11 INFO - 'HOME': '/home/cltbld', 14:05:11 INFO - 'LANG': 'en_US.UTF-8', 14:05:11 INFO - 'LANGUAGE': 'en_US:en', 14:05:11 INFO - 'LOGNAME': 'cltbld', 14:05:11 INFO - 'MAIL': '/var/mail/cltbld', 14:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:11 INFO - 'MOZ_NO_REMOTE': '1', 14:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:11 INFO - 'NO_EM_RESTART': '1', 14:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:11 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:11 INFO - 'SHELL': '/bin/bash', 14:05:11 INFO - 'SHLVL': '1', 14:05:11 INFO - 'TERM': 'linux', 14:05:11 INFO - 'TMOUT': '86400', 14:05:11 INFO - 'USER': 'cltbld', 14:05:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:11 INFO - '_': '/tools/buildbot/bin/python'} 14:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:11 INFO - Running setup.py (path:/tmp/pip-FINagk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:11 INFO - Running setup.py (path:/tmp/pip-JcXbiH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:11 INFO - Running setup.py (path:/tmp/pip-U4Y8aW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:11 INFO - Running setup.py (path:/tmp/pip-5_yl64-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:11 INFO - Running setup.py (path:/tmp/pip-BcBhqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:11 INFO - Running setup.py (path:/tmp/pip-QAPBAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:11 INFO - Running setup.py (path:/tmp/pip-YBaXGD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:12 INFO - Running setup.py (path:/tmp/pip-FeeSA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:12 INFO - Running setup.py (path:/tmp/pip-Tr9xHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:12 INFO - Running setup.py (path:/tmp/pip-xSedIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:12 INFO - Running setup.py (path:/tmp/pip-W04tR0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:12 INFO - Running setup.py (path:/tmp/pip-zWiGwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:12 INFO - Running setup.py (path:/tmp/pip-havn6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:12 INFO - Running setup.py (path:/tmp/pip-PKmvBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:12 INFO - Running setup.py (path:/tmp/pip-O7kc8C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:12 INFO - Running setup.py (path:/tmp/pip-CpqCOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:12 INFO - Running setup.py (path:/tmp/pip-ohmceq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:12 INFO - Running setup.py install for manifestparser 14:05:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:05:12 INFO - Running setup.py install for mozcrash 14:05:12 INFO - Running setup.py install for mozdebug 14:05:13 INFO - Running setup.py install for mozdevice 14:05:13 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for mozfile 14:05:13 INFO - Running setup.py install for mozhttpd 14:05:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for mozinfo 14:05:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for mozInstall 14:05:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for mozleak 14:05:13 INFO - Running setup.py install for mozlog 14:05:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for moznetwork 14:05:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:05:13 INFO - Running setup.py install for mozprocess 14:05:13 INFO - Running setup.py install for mozprofile 14:05:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:05:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:05:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:05:14 INFO - Running setup.py install for mozrunner 14:05:14 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:05:14 INFO - Running setup.py install for mozscreenshot 14:05:14 INFO - Running setup.py install for moztest 14:05:14 INFO - Running setup.py install for mozversion 14:05:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:05:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:14 INFO - Cleaning up... 14:05:14 INFO - Return code: 0 14:05:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05: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')]} 14:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:14 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:14 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 14:05:14 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 14:05:14 INFO - Using env: {'DISPLAY': ':0', 14:05:14 INFO - 'HOME': '/home/cltbld', 14:05:14 INFO - 'LANG': 'en_US.UTF-8', 14:05:14 INFO - 'LANGUAGE': 'en_US:en', 14:05:14 INFO - 'LOGNAME': 'cltbld', 14:05:14 INFO - 'MAIL': '/var/mail/cltbld', 14:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:14 INFO - 'MOZ_NO_REMOTE': '1', 14:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:14 INFO - 'NO_EM_RESTART': '1', 14:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:14 INFO - 'SHELL': '/bin/bash', 14:05:14 INFO - 'SHLVL': '1', 14:05:14 INFO - 'TERM': 'linux', 14:05:14 INFO - 'TMOUT': '86400', 14:05:14 INFO - 'USER': 'cltbld', 14:05:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:14 INFO - '_': '/tools/buildbot/bin/python'} 14:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:14 INFO - Running setup.py (path:/tmp/pip-cfXYPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:14 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)) 14:05:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:14 INFO - Running setup.py (path:/tmp/pip-rYCGss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:14 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)) 14:05:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:14 INFO - Running setup.py (path:/tmp/pip-EX11yF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:14 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)) 14:05:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:14 INFO - Running setup.py (path:/tmp/pip-19FW8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:15 INFO - Running setup.py (path:/tmp/pip-ZNr_WA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:15 INFO - Running setup.py (path:/tmp/pip-y3mspg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:15 INFO - Running setup.py (path:/tmp/pip-LiXkma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:15 INFO - Running setup.py (path:/tmp/pip-b95Goq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:15 INFO - Running setup.py (path:/tmp/pip-TU9r6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:15 INFO - Running setup.py (path:/tmp/pip-m68QWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:15 INFO - Running setup.py (path:/tmp/pip-RBa6f1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:15 INFO - Running setup.py (path:/tmp/pip-7O7gbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:15 INFO - Running setup.py (path:/tmp/pip-9VLYER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:15 INFO - Running setup.py (path:/tmp/pip-LDfYU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:15 INFO - Running setup.py (path:/tmp/pip-Xu7ceY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:15 INFO - Running setup.py (path:/tmp/pip-UxwqlA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:15 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)) 14:05:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:15 INFO - Running setup.py (path:/tmp/pip-R_g64B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:15 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)) 14:05:15 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)) 14:05:15 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)) 14:05:15 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)) 14:05:15 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)) 14:05:15 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)) 14:05:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:15 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 14:05:15 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 14:05:15 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 14:05:15 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 14:05:15 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 14:05:15 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 14:05:17 INFO - Downloading blessings-1.5.1.tar.gz 14:05:17 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 14:05:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:17 INFO - Installing collected packages: blessings 14:05:17 INFO - Running setup.py install for blessings 14:05:17 INFO - Successfully installed blessings 14:05:17 INFO - Cleaning up... 14:05:17 INFO - Return code: 0 14:05:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:05:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:18 INFO - Reading from file tmpfile_stdout 14:05:18 INFO - Current package versions: 14:05:18 INFO - argparse == 1.2.1 14:05:18 INFO - blessings == 1.5.1 14:05:18 INFO - blobuploader == 1.2.4 14:05:18 INFO - docopt == 0.6.1 14:05:18 INFO - manifestparser == 1.1 14:05:18 INFO - mozInstall == 1.12 14:05:18 INFO - mozcrash == 0.16 14:05:18 INFO - mozdebug == 0.1 14:05:18 INFO - mozdevice == 0.47 14:05:18 INFO - mozfile == 1.2 14:05:18 INFO - mozhttpd == 0.7 14:05:18 INFO - mozinfo == 0.9 14:05:18 INFO - mozleak == 0.1 14:05:18 INFO - mozlog == 3.1 14:05:18 INFO - moznetwork == 0.27 14:05:18 INFO - mozprocess == 0.22 14:05:18 INFO - mozprofile == 0.28 14:05:18 INFO - mozrunner == 6.11 14:05:18 INFO - mozscreenshot == 0.1 14:05:18 INFO - mozsystemmonitor == 0.0 14:05:18 INFO - moztest == 0.7 14:05:18 INFO - mozversion == 1.4 14:05:18 INFO - psutil == 3.1.1 14:05:18 INFO - requests == 1.2.3 14:05:18 INFO - wsgiref == 0.1.2 14:05:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05:18 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')]} 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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')]} 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:18 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 14:05:18 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 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 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)) 14:05:18 INFO - Cleaning up... 14:05:18 INFO - Return code: 0 14:05:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:05:18 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')]} 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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')]} 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:18 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 14:05:18 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 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:18 INFO - Downloading/unpacking jsonschema 14:05:18 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 14:05:18 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 14:05:18 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 14:05:18 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 14:05:18 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 14:05:18 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 14:05:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:20 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 14:05:20 INFO - Downloading/unpacking functools32 (from jsonschema) 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:05:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:20 INFO - warning: no files found matching '*.txt' 14:05:20 INFO - no previously-included directories found matching 'build' 14:05:20 INFO - no previously-included directories found matching 'dist' 14:05:20 INFO - no previously-included directories found matching '.git*' 14:05:20 INFO - Installing collected packages: jsonschema, functools32 14:05:20 INFO - Running setup.py install for functools32 14:05:20 INFO - warning: no files found matching '*.txt' 14:05:20 INFO - no previously-included directories found matching 'build' 14:05:20 INFO - no previously-included directories found matching 'dist' 14:05:20 INFO - no previously-included directories found matching '.git*' 14:05:20 INFO - Successfully installed jsonschema functools32 14:05:20 INFO - Cleaning up... 14:05:20 INFO - Return code: 0 14:05:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:05:20 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')]} 14:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:20 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')]} 14:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:20 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 0x7fecadc27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, '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': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', '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 14:05:20 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 14:05:20 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 14:05:20 INFO - Using env: {'DISPLAY': ':0', 14:05:20 INFO - 'HOME': '/home/cltbld', 14:05:20 INFO - 'LANG': 'en_US.UTF-8', 14:05:20 INFO - 'LANGUAGE': 'en_US:en', 14:05:20 INFO - 'LOGNAME': 'cltbld', 14:05:20 INFO - 'MAIL': '/var/mail/cltbld', 14:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:20 INFO - 'MOZ_NO_REMOTE': '1', 14:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:20 INFO - 'NO_EM_RESTART': '1', 14:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:20 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:20 INFO - 'SHELL': '/bin/bash', 14:05:20 INFO - 'SHLVL': '1', 14:05:20 INFO - 'TERM': 'linux', 14:05:20 INFO - 'TMOUT': '86400', 14:05:20 INFO - 'USER': 'cltbld', 14:05:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:20 INFO - '_': '/tools/buildbot/bin/python'} 14:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:21 INFO - Downloading/unpacking flake8 14:05:21 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 14:05:21 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 14:05:21 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 14:05:21 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 14:05:21 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 14:05:21 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 14:05:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:05:22 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 14:05:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:05:22 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 14:05:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:22 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 14:05:23 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 14:05:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:05:23 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 14:05:23 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 14:05:23 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 14:05:23 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 14:05:23 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 14:05:23 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 14:05:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:05:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:23 INFO - no previously-included directories found matching 'docs/_build' 14:05:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:05:23 INFO - Running setup.py install for pep8 14:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:23 INFO - no previously-included directories found matching 'docs/_build' 14:05:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:05:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:05:23 INFO - Cleaning up... 14:05:23 INFO - Return code: 0 14:05:23 INFO - Running post-action listener: _resource_record_post_action 14:05:23 INFO - Running post-action listener: _start_resource_monitoring 14:05:23 INFO - Starting resource monitoring. 14:05:23 INFO - ##### 14:05:23 INFO - ##### Running install step. 14:05:23 INFO - ##### 14:05:23 INFO - Running pre-action listener: _resource_record_pre_action 14:05:23 INFO - Running main action method: install 14:05:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:23 INFO - Reading from file tmpfile_stdout 14:05:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:05:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:05:23 INFO - Reading from file tmpfile_stdout 14:05:23 INFO - Output received: 14:05:23 INFO - Usage: mozinstall [options] installer 14:05:23 INFO - Options: 14:05:23 INFO - -h, --help show this help message and exit 14:05:23 INFO - -d DEST, --destination=DEST 14:05:23 INFO - Directory to install application into. [default: 14:05:23 INFO - "/builds/slave/test-pgo"] 14:05:23 INFO - --app=APP Application being installed. [default: firefox] 14:05:23 INFO - mkdir: /builds/slave/test-pgo/build/application 14:05:23 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'] 14:05:23 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 14:05:39 INFO - Reading from file tmpfile_stdout 14:05:39 INFO - Output received: 14:05:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:05:39 INFO - Running post-action listener: _resource_record_post_action 14:05:39 INFO - ##### 14:05:39 INFO - ##### Running run-tests step. 14:05:39 INFO - ##### 14:05:39 INFO - Running pre-action listener: _resource_record_pre_action 14:05:39 INFO - Running main action method: run_tests 14:05:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:05:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:05:39 INFO - Python 2.7.3 14:05:39 INFO - Return code: 0 14:05:39 INFO - grabbing minidump binary from tooltool 14:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:39 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 0x2bee840>, '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 0x2b5b6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5bb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:05:39 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 14:05:39 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 14:05:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:40 INFO - Return code: 0 14:05:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:05:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:05:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:05:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:05:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:05:41 INFO - Return code: 0 14:05:41 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:05:41 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:05:41 INFO - Using env: {'DISPLAY': ':0', 14:05:41 INFO - 'HOME': '/home/cltbld', 14:05:41 INFO - 'LANG': 'en_US.UTF-8', 14:05:41 INFO - 'LANGUAGE': 'en_US:en', 14:05:41 INFO - 'LOGNAME': 'cltbld', 14:05:41 INFO - 'MAIL': '/var/mail/cltbld', 14:05:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:41 INFO - 'MOZ_NO_REMOTE': '1', 14:05:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:41 INFO - 'NO_EM_RESTART': '1', 14:05:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:41 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:05:41 INFO - 'SHELL': '/bin/bash', 14:05:41 INFO - 'SHLVL': '1', 14:05:41 INFO - 'TERM': 'linux', 14:05:41 INFO - 'TMOUT': '86400', 14:05:41 INFO - 'USER': 'cltbld', 14:05:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270', 14:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:41 INFO - '_': '/tools/buildbot/bin/python'} 14:05:41 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:05:41 INFO - mozversion application_buildid: 20160112113026 14:05:41 INFO - mozversion application_changeset: 743089edf783c1fd6f174d25cd474c87bce91061 14:05:41 INFO - mozversion application_display_name: Nightly 14:05:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:41 INFO - mozversion application_name: Firefox 14:05:41 INFO - mozversion application_remotingname: firefox 14:05:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:05:41 INFO - mozversion application_vendor: Mozilla 14:05:41 INFO - mozversion application_version: 46.0a1 14:05:41 INFO - mozversion platform_buildid: 20160112113026 14:05:41 INFO - mozversion platform_changeset: 743089edf783c1fd6f174d25cd474c87bce91061 14:05:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:05:41 INFO - mozversion platform_version: 46.0a1 14:05:41 INFO - using testdate: 1452636341 14:05:41 INFO - actual date: 1452636341 14:05:41 INFO - starting webserver on 'localhost:51221' 14:05:41 INFO - SUITE-START | Running 3 tests 14:05:41 INFO - TEST-START | dromaeo_css 14:05:41 INFO - operating with platform_type : linux_ 14:05:41 INFO - Initialising browser for dromaeo_css test... 14:05:41 INFO - TEST-INFO | started process 24526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpje4Owm/profile http://localhost:51221/getInfo.html) 14:05:44 INFO - PROCESS | 24526 | __metrics Screen width/height:1600/1200 14:05:44 INFO - PROCESS | 24526 | colorDepth:24 14:05:44 INFO - PROCESS | 24526 | Browser inner width/height: 1024/697 14:05:44 INFO - PROCESS | 24526 | __metrics 14:05:44 INFO - PROCESS | 24526 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:45 INFO - PROCESS | 24526 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:46 INFO - TEST-INFO | 24526: exit 0 14:05:46 INFO - Browser initialized. 14:05:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:05:46 INFO - TEST-INFO | started process 24618 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpje4Owm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:57 INFO - PROCESS | 24618 | RSS: Main: 148176896 14:05:57 INFO - PROCESS | 24618 | 14:06:49 INFO - PROCESS | 24618 | 1452636409345 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] 14:08:57 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51221/tests/dromaeo/cssquery-ext.html) 14:08:58 INFO - PROCESS | 24618 | RSS: Main: 237268992 14:08:58 INFO - PROCESS | 24618 | 14:12:00 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-ext.html (next: http://localhost:51221/tests/dromaeo/cssquery-jquery.html) 14:12:01 INFO - PROCESS | 24618 | RSS: Main: 225320960 14:12:01 INFO - PROCESS | 24618 | 14:15:03 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51221/tests/dromaeo/cssquery-mootools.html) 14:15:03 INFO - PROCESS | 24618 | RSS: Main: 227434496 14:15:03 INFO - PROCESS | 24618 | 14:18:05 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51221/tests/dromaeo/cssquery-prototype.html) 14:18:06 INFO - PROCESS | 24618 | RSS: Main: 209846272 14:18:06 INFO - PROCESS | 24618 | 14:21:08 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51221/tests/dromaeo/cssquery-yui.html) 14:21:09 INFO - PROCESS | 24618 | RSS: Main: 213430272 14:21:09 INFO - PROCESS | 24618 | 14:24:11 INFO - PROCESS | 24618 | Cycle 1(1): loaded http://localhost:51221/tests/dromaeo/cssquery-yui.html (next: http://localhost:51221/tests/dromaeo/cssquery-dojo.html) 14:24:12 INFO - PROCESS | 24618 | RSS: Main: 271605760 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | __start_tp_report 14:24:12 INFO - PROCESS | 24618 | _x_x_mozilla_page_load 14:24:12 INFO - PROCESS | 24618 | _x_x_mozilla_page_load_details 14:24:12 INFO - PROCESS | 24618 | |i|pagename|runs| 14:24:12 INFO - PROCESS | 24618 | |0;dojo.html;3145.779795414321;3162.8576714047867;3198.9840050799758;3203.3273012667323;3222.7421806255493;5065.062963351783;5132.050570644429;5149.485051494853;5165.147750621143;5190.169572868342;5158.742062896849;5194.584433245341;5199.558037566811;5229;5324.201369794533;4565.2467342888385;4677.602403795681;4713.457952335491;4776.8566942991765;4837.129316722989;4794.880127996793;4803.759812009385;4823.782929768169;4879.316895634596;4901.387326584177;4662.393888794452;4683.039976804781;4723.4331880174595;4730.668853180296;4759.7620118994255;4683.180443422388;4702.059588082363;4705.294205869112;4719.882002949919;4754.477007529169;4629.166749985001;4669.276262179334;4681.765911704401;4700.106979673851;4735.455422626407;5026.145555255615;5033.471485494044;5080.060188865072;5084.415292241402;5089.44016158226;5494;5501.422350653163;5501.834944951658;5503.11950087988;5506.311711036121;5507.752151153168;5531.695756733378;5545.916811247835;5585.078462053756;5587.664740115565;5113.156329205676;5195.844124676228;5222.451642577551;5223.686578805284;5265.104932161542;5648.802291919763;5651.0675738503505;5652.18043383707;5655.5475561954945;5657.915131273035;5374.543163831118;5425.728713564306;5430.402655707869;5436.184572314184;5436.864078398072;5475.370332411823;5476.972615136899;5498.505134537911;5503.367112782082;5525.889482210333;5421.430749771217;5429.131338985743;5437.211604317352;5440.591955603267;5443.972780136074;5384.91922621161;5431.2667789847865;5435.10320797064;5483.287172667608;5516.338039435213;4331.306990881444;4333.6316413104605;4336.609705126553;4367.847125350598;4374.737515749065;3840.1551658635058;3862.0344913771555;3869.1294458746556;3901.1027463683513;3906.121122747359;5126.743662816919;5167.22491626259;5177.948220517822;5180.585553155738;5182.6372153949615;5481.671099734029;5519.475649813261;5519.69641669704;5542;5546.861328466821;5127.128388174019;5161.535461808456;5171.50870667286;5174.482551744795;5225.973870130625;4694.342792009122;4717.8348757794;4754.7147171169845;4780.306855505932;4859.781309840995;5655.717214139277;5659.858503537444;5664.405237450091;5667.1499275108235;5685.886282274331;5445.59158063139;5449.3460784706085;5454.672719636835;5462.3445186577865;5503.449655034465;5665.065264231355;5736.799212027726;5774.047282198559;5802.738876750472;5852.18069470266;5396.028714831211;5402.783888644411;5409.242706021081;5416.674999499885;5417.539509141767;5430.456954304696;5476.397596264328;5480.095784195563;5509.173623956439;5522.447755224445;5399.352077750538;5466.699331536644;5484.451554844483;5489.58828087887;5544.168374743821;5347.866303342447;5365.624406291522;5368.785248590013;5372.946270537401;5383.192521121863;5222.060029194781;5252.527272545489;5258.605604579595;5318.8936221276135;5321.9467805323;5351.892962140658;5362.892742145214;5387.973060134675;5431.728413579384;5440.047991601533;5281.683099014072;5296.761645725875;5298.993191293642;5299.894002119859;5301.1518157096225 14:24:12 INFO - PROCESS | 24618 | |1;ext.html;500.29708259894835;513.7944822071169;518.846940152655;524.569852720769;546.1507356061325;29073.273168170806;29578.408431831405;29637.703622963763;29653.70346296539;36936.44595331072;40662.796686016525;40984.38523422151;41104.38343424851;41195.79402102993;41300.79349603248;8393;8606;8608.52653104079;8609.26821220194;8614.483131012128;8396.328293736486;8498.787530311762;8505.064442911274;8547.914520854805;8553.144685531459;8516.23353898149;8605.39762216645;8612.09572994836;8614.698485553006;8808.64765409383;8623.611937462798;8703.782405439852;8708.738737837875;8715.825683486359;8723.869141962843;8545.188207120314;8690.913635795525;8692.869606955901;8697.043325234219;8702.956485217534;39406.40890386647;39674.801625991975;39702.20595588101;39784.80107599472;39799;3219.7263232625255;3222.822744749038;3249.155219642886;3264.836758162106;3656.2687462507606;29920;30091.849540752373;30131.849340753375;30251.69748302511;31181.220469488217;3953.6639385652256;3964.940525892114;3992.161646054332;4028.637422631977;4190.895227619303;256632;256795;257034.99999999814;257185.71407143032;257827;53014;53890.730546347804;58198;59602;60830.69584652048;54977.45022549803;55177.72411137919;55264.72367638136;55270;55447.44552554504;13692.452301908012;14330.928345358416;14555.671092625129;14567.344469498687;14579.271036448135;9473.621055157717;11064.834027489595;11162.776744465227;11215.271007384494;11242.38166900812;18819;19007.524811879535;19012.429627111207;19385.709214361796;19577.216911323387;7316.926830731731;7482.176960534337;7522.504386553584;7587.2412758723685;7657.578833164118;862.3920136303891;934.8364036293622;940.3182692547848;1006.5571148694551;1015.4465816130227;27735;27812.30469238285;27847.86236490779;27877.16368508948;27898.302542436195;995.8257304971601;1001.8397056471075;1028.3264461777549;1050.810854046279;1146.7419830538063;12634.178778379375;12883.33797382762;13071.803922941164;13129.868701313055;13169.53906613264;300185;305160;305820;306634;307152;50013;50438.443002409454;50450.49549504531;50582.49417505851;50589;1123.8482804821408;1236.6228300368473;1329.5811819276896;1356.620146359021;1381.0470775165104;24874.751252487244;25176;25757.227283181535;25793.097241596453;27458.725412746415;43493.56506434895;43502.56497435112;43866.56133438752;43979.34030989474;43989.560104398544;276174;280840;371928;375445;378811;30631.846840765655;30762.53856192114;30782;30782.076537703906;30782.538261926537;42950.78524607357;42971.3554296692;43372.34941475943;44164.11671766611;44368.33447498226;36709.44935826018;36751.448728268566;37539.62460375361;37546.624533754315;38134;36857.447138293486;36954.01120848759;37142.25715485621;37453.4381984265;37828.621713783614;33190;33421.33157336888;33740.49389259212;33809.49285760667;34183.14542136367;28217.71782282151;29326.70673293325;30074.398512030075;31710.152737651097;32974.83512582422;20558.897205513877;20683.896580517605;20894.61908990385;20983.265585704426;21924.45188870227 14:24:12 INFO - PROCESS | 24618 | |2;jquery.html;360.79074137000543;362.83309677548345;363.79263819622815;366.3680151738251;367.99632003679955;13518.662033449169;13617.182969021866;15942.36230550778;16756.2459689314;17742.46772596821;15050.548483545484;15159.393624255017;15510.612234694137;15828.525144245663;15833.841661583381;5146.176611742113;5340.225667278242;5342.118550439173;5346.812861549846;5346.893062138755;3940.6453419192267;4041.312976793937;4716.669833111667;5431.456854314576;5727.083666613343;5721.8569535761735;5891.58758886876;5939.168516407706;5942;5943.375945525722;5781.971090144564;5810.041343178371;5830.212921255661;5838.678872662002;5841.678707671076;4976.850694479172;5152.742362881841;5153.948460515385;5184.377874655065;5189.7405129743365;19085.332013379466;19344.80655193444;19540.511487212792;19684.606307873906;19694.113764880472;1970.1528342812585;2043.1010355443707;2055.5580550181785;2137.7648458669532;2170.4031391367344;11935;12389;12610.432530536056;12729;12729.108962372638;1761.4363403710818;1811.157811617591;1832.6792811257976;1864.4313484387255;1891.6689579323702;53911;54203;54305.45694543044;55132.44867551313;55258.17112743312;9476.526173691287;9585.281103917094;9680.46757428334;9709.70870873875;9766.07222313879;12782.735421532907;12911.483540658268;12919.289439080752;12927.741445171045;12931.5473958411;7018.894716579255;7050.92949070513;7054.08296921397;7102.112235970504;7122.964385178041;6658.3341665834;6679.866402672016;6740.561863478858;6756.054152418666;6769.8646027079185;5706.600537962303;5778.711064446761;5820.592558520948;5861.794837180678;5914.053751399755;1647.604574902015;1678.144146485277;1715.9914200428918;1721.3630956545908;1751.3607533250272;920.2408013388981;920.9861852072224;924.4499522783933;978.5682578791697;983.1937810994915;15738.606534836492;15955.760663590056;16099.275532601061;16412.671746565004;16536.917315413586;823.3877799741429;854.0775961961067;897.6813231302793;971.9271054670786;980.8921018687938;8697.782555436039;8943.955280223558;8954.2836573074;9001.774955626162;9010.693449449793;508149;511240;514195;518563;520119;67002.3299766996;72206;73488;73737.6313118431;74492.53044817329;1080.6325849211148;1109.1016276815806;1118.4519585403257;1119.5130118398522;1125.6679279612697;13332;14500.637484062983;14519.274036298355;14620.707585848437;15069.47256846005;30511.54232686467;30792.84603576968;30853.537196941616;31600.841995789873;31916.361672766878;39033.414498781975;39174.41238381484;39181;39212;39253.41119883147;6891.1738389325865;6944.097267355211;7027.437804975488;7113.181984071691;7212.42300615939;9070.274378049608;10861.619843305447;11066.114710822954;11105.111591072857;11211.943940280247;9101.954490227507;9232.261419086592;9360.204382627553;9579.377340472847;9734.464604446823;9164.587593558439;9327.207187389147;9588.472634005197;9749.07383798538;10031.398116113056;9286.489243091695;9387.765305867408;9666.516674166403;9725.238787116152;9842.311038227255;6147.170132032118;6203.689815509116;6973.163220413583;7150.606716630427;7296.7446139384865;8836.867446988172;8935.865962010705;9234.769130771785;9262.39794413361;9353.298502612195 14:24:12 INFO - PROCESS | 24618 | |3;mootools.html;1302.1015499305483;1448.0587618048264;1463.7511623024084;1595.5213435969206;1779.80422153563;7001.159860816702;7634.389248860091;7689.077310722721;7759.495632783865;7760.340371068459;7703.807404814883;7737.690492380298;7757.534547927128;7766.262205090521;7773.68905243791;2315.525317309952;2335.602947498929;2336.334144768741;2336.901656221573;2339.508703172336;2304.9078036878504;2307.1232931486097;2345.7771511706446;2352.0709319818748;2361.4332560185517;2342.812574994005;2366.2782851230368;2369.5497855407502;2370.277065495023;2372.323887692008;2332.207049603143;2363.0665886974634;2363.527294541099;2370.2533701883935;2371.893264803088;2361.303415492434;2363.645453182019;2364.160722943365;2364.3498038039506;2366.372911178539;7755.302022817917;7935.2064793520185;7942.086660034112;7965.084015338252;7987.121416644164;4801.4718380978065;4882.731449770261;4893.755312234374;4908.067467181224;4911.705297682151;3043.6195475565555;3085.861136248874;3120.3603261331373;3123.593932788746;3173.1273899677544;992.3103443107043;1014.5890914179769;1039.5270152080784;1046.670298855858;1072.0940805019745;10470.371777693286;10539.051485366277;10553.050225479743;10559.68320950365;10559.736006599896;4235.682323825726;4259.27592309302;4336.067745434747;4450.35469856869;4455.398521199597;8768.07935166811;8819.867701984474;8822.338324625678;8824.602892869836;8843.027267000625;4955.554000140005;4960.479149689303;4960.925586116211;4967.925481117786;4968.031233909425;4017.4375587417785;4082.081531655413;4406.140802543473;4453.198424283595;4529.456465224194;3570.393033184365;3607.6933460656137;3611.3138503684218;3629.872954446582;3636.1455058061333;1029.6602121299952;1112.5494174859195;1118.8881111888745;1125.662301309604;1129.6780417581115;1020.1430798129459;1056.9260151789301;1106.4633652678444;1159.1596092832797;1289.6775806048488;7073.752418665322;7181.856362872818;7211.675474603656;7219.675114619749;7241.203467618558;626.9467095296951;636.0745115856417;638.6710843915388;644.4972921121532;777.2693667952107;5195.948040519622;5220.738963051832;5318.388385335658;5443.183522471581;5528.75120619573;9227.016191518856;9476;9551.42691438502;9557.23542116629;9585.856212156823;9344.813103737888;9378.765530861783;9416.811663766686;9615.56729947154;9668.129868311886;7399.889001664979;7476.70093196277;7523.134839493418;7536.171021187665;7556.433267504959;6843.8973415399805;6868.553544019623;6890.173179218526;6960.512764106464;6975.197852247056;8534.70128545498;8602.483850968962;8672.349573781865;8732.69435569752;8754.649814007369;8699.173578510032;8937.28501719874;8970.551472426221;9046.683366082156;9047.683331083645;6428.4857211423905;6485.383888530582;6488.578242414228;6491.318411566906;6495.935040649533;7214.062171917617;7353.301436363537;7362.595057271901;7392.8891066635115;7461.253874612496;6481.384268494486;6892.104026476526;7043.929560704328;7063.71745130189;7084.043654106629;6643.634600096848;6827.351401616838;6894;6967;6993.790186294419;6297.874042519215;6303.36966303366;6304.936950630618;6311.305756366704;6315.715792789428;6311.084892690626;6367.872642547216;6381.106645069601;6383.106365108795;6385.808425747235;6308.053791931247;6349.714262858275;6405.583637063763;6418.101465794886;6450.322716114741 14:24:12 INFO - PROCESS | 24618 | |4;prototype.html;324.98700051997923;334.794101627499;350.346603584315;352.3745352000199;362.4346020208475;5791.276090488689;5830.154627579004;5843.328017278014;5857.209276747638;5897.882042359151;5543.085390910505;5570.415106413819;5697.344805347387;5774;5790.218320526727;4520.321951707254;4531.682782205238;4541.772911354436;4551.089782043588;4554.681172317939;4331.3719510670935;4541.977290113545;4556.84051058213;4557.475890272628;4561.042181141964;4350.282203436429;4373.890652733675;4426.756528390937;4428.424304840366;4488.23699971004;4460.754658493782;4463.620592249663;4467.24056910326;4474.172278128541;4493.326001099845;3927.5483319418063;3928.7446315989655;3929.5284565851994;3932.3315036443873;3936.822842972073;5384.838454846361;5505.834824955217;5517.834464966058;5519.613627046108;5524.502794748492;5163.819266325698;5166.121759300928;5167.7674504647;5169.431362550116;5176.094183517869;6109.938900610981;6111.572189946705;6112.022076467744;6115.357887421846;6118.418750218722;4305.246581848164;4317.935230971507;4322.308430651081;4329.870103896857;4337.067530480962;6282.183316168915;6401.711922963478;6409.583377080475;6421.068945002995;6425.068365087036;4343.19650864591;4358.5205627380965;4363.214621368184;4363.847265345697;4367.082912588392;4371.082072764755;4416.050549131952;4418.779061046935;4422.778861056934;4423.933640995388;5095.235714642833;5119.257707632372;5120.846374608767;5126.641135120506;5127.717975511383;5981.581289309794;6170;6174.783882564178;6181.474574661114;6181.567290289637;1596.8323326050597;1614.5479265805593;1627.4954764023191;1630.722777127891;1632.2002218912646;1112.6884472347756;1123.4607388453587;1124.1288001798507;1143.8512993310983;1144.7824913266452;5883.499902508334;5884.411558844081;5884.735186916599;5892.263467066617;5898.14476900847;6347.301796802348;6349.8730025400155;6358.618482891041;6364.140840986408;6365.2998170201245;5674.205611214434;5741.971290143522;5817.592768506164;5824.941750582525;5844.152597873284;3374.257663314067;3381.120908563791;3395.898123056312;3402.4385976314124;3407.5910890693276;6620.933790662032;6677.298883617247;6682.832929176712;6721.025451309532;6759.864802703918;6375.521835862329;6502.219733631994;6509.804705858832;6559.704813283413;6575.572587781779;6667.833304167338;6672.499562532829;6684.231313398924;6691.59850408977;6698.5980841149685;6365.140706004815;6393.232812062396;6406.494473798561;6417.518686098468;6417.711202995783;6121.3878612140215;6322.399372059647;6338.809835704937;6349.07938348946;6351.237851457855;6671.532992690465;6677.499187561049;6688.83277918056;6691;6694.4644428444635;4423.159599676052;4462.665300102441;4464.441944756905;4465.866024019285;4467.329900514819;6242.65665388408;6389.52078594098;6394.840128996626;6399.648019358794;6405.231372235362;6208.782692605737;6232.25212974446;6234.875302494015;6236.469900058364;6237.469815065589;6244.094606282155;6245.750849830143;6245.781397651061;6248.968755156195;6259.467945224706;5863.618864773776;6097.146399504161;6110.114033465212;6112.510999119971;6117.449429551361;6244.0321750128805;6251.187345645219;6251.468625166912;6253.405926436982;6254.093156492374;6123.14276001369;6126;6127.479164271087;6129.938700612936;6132.8773424532155 14:24:12 INFO - PROCESS | 24618 | |5;yui.html;753.1790348520112;814.4543156085422;847.8558645030345;853.4239388412819;875.4047247871445;13440.126391784526;13543.661408464794;13584.660383490418;13634.250116243602;13640.931795341034;12223.266604003766;12269.693257668563;12278;12282.385880705951;12290.631281061582;649.9512536559753;662.5130529061137;785.426638553856;807.7697856111009;809.1746418652971;819.397742659145;830.5847076461769;833.0669649992018;833.3874602167402;833.5790425834975;674.8684006618711;859.8624220124781;862.5687156421789;863.6804382378529;863.7926897544576;694.4964900447161;840.5125027484075;861.1173547114196;862.4695812075529;864.2653744317342;629.3517676792865;630.5271046714964;631.9620822750604;631.9778807741707;632.4118569730149;13122.540711075162;13137.671558211026;13186.142900711424;13228.603141905758;13235;12544.498220071186;12588.307643079626;12671.36643167838;12914.160579562393;13184.406701698446;10064.496775161286;10128.240381971307;10208.081272685495;10494.317869338469;10587.369175056747;3565.322588708163;3651.397519409294;3664.175560498893;3669.87155449558;3740.60723624021;44721.105577888586;44857.32714009292;45331;45363;45558.54441455576;9372.8594071089;9481.90518094824;9692.127708506268;9920.156786673213;9984.251181161442;17049;17090.743638845426;17110.486685399457;17118.058506782247;17763.822361776474;7801.453898227183;7871.212878712083;7909;7946.364290856717;8166.060902996112;4420.58004489573;4465.42638134782;4515.68390212682;4533.795979180944;4546.818127274938;3048.7713421493477;3056.266496040979;3082.722554970019;3102.30198205402;3108.564800927872;562.4150883081631;578.7048605211372;591.6095377051212;595.1964847455899;620.2866703291252;612.317266248139;636.9172007638978;654.1626717801222;684.1482354468718;697.3061803505544;7905.960470197727;9060;9095.727128186032;9218.58516366765;9294.302927280482;523.7695414017896;567.1662655895826;640.9359064093553;665.9600423974578;689.6586189836063;3938.9606103938595;3946.2896678598127;4134.772587507716;4162.500499940026;4162.791860406967;59048;59992.400075999554;60122.39877601255;60338;60417.09374359388;47453;47832.5216747835;48338.5166148341;48471;48934.510654893;43363.78318108389;43590;43792.343114852665;43952;44525;8249.587520624065;8346.916530834615;8412.495250285003;8461.153884611489;8512.233898949124;34141;34165.829170853984;34764.82617586896;35326.64673353233;35375.64624353724;39997.40003899886;41706.374404384565;43850;43904.56095439005;44214.778926105166;11009.504572294105;11066;11102.833457497982;11337.03635191018;11652.94173529127;11278.266912650652;11375.54497820078;11411.771764564495;11611.941940290244;12000.399980001139;9894.15899648538;10006.249531285037;10207.489625518843;10322.793544129225;10377.117944974761;10710.839337410102;11330.150238731963;11387.544498219979;11409.087273018305;11805.704857378634;10605.363678179334;10621.734456638645;10624.096951759188;10661.253712240068;10941.671749847517;8822.911770882465;9057.230135438562;9460.243180545402;9467.573959171992;9470.573824178065;7969.203079691984;8257.917420825715;8364.330853531825;8462;9033.187013168847 14:24:12 INFO - PROCESS | 24618 | __end_tp_report 14:24:12 INFO - PROCESS | 24618 | __start_cc_report 14:24:12 INFO - PROCESS | 24618 | _x_x_mozilla_cycle_collect,737 14:24:12 INFO - PROCESS | 24618 | __end_cc_report 14:24:12 INFO - PROCESS | 24618 | __startTimestamp1452637452139__endTimestamp 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | ------- Summary: start ------- 14:24:12 INFO - PROCESS | 24618 | Number of tests: 6 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#0] dojo.html Cycles:165 Average:5134.25 Median:5318.89 stddev:536.00 (10.1%) stddev-sans-first:514.45 14:24:12 INFO - PROCESS | 24618 | Values: 3145.8 3162.9 3199.0 3203.3 3222.7 5065.1 5132.1 5149.5 5165.1 5190.2 5158.7 5194.6 5199.6 5229.0 5324.2 4565.2 4677.6 4713.5 4776.9 4837.1 4794.9 4803.8 4823.8 4879.3 4901.4 4662.4 4683.0 4723.4 4730.7 4759.8 4683.2 4702.1 4705.3 4719.9 4754.5 4629.2 4669.3 4681.8 4700.1 4735.5 5026.1 5033.5 5080.1 5084.4 5089.4 5494.0 5501.4 5501.8 5503.1 5506.3 5507.8 5531.7 5545.9 5585.1 5587.7 5113.2 5195.8 5222.5 5223.7 5265.1 5648.8 5651.1 5652.2 5655.5 5657.9 5374.5 5425.7 5430.4 5436.2 5436.9 5475.4 5477.0 5498.5 5503.4 5525.9 5421.4 5429.1 5437.2 5440.6 5444.0 5384.9 5431.3 5435.1 5483.3 5516.3 4331.3 4333.6 4336.6 4367.8 4374.7 3840.2 3862.0 3869.1 3901.1 3906.1 5126.7 5167.2 5177.9 5180.6 5182.6 5481.7 5519.5 5519.7 5542.0 5546.9 5127.1 5161.5 5171.5 5174.5 5226.0 4694.3 4717.8 4754.7 4780.3 4859.8 5655.7 5659.9 5664.4 5667.1 5685.9 5445.6 5449.3 5454.7 5462.3 5503.4 5665.1 5736.8 5774.0 5802.7 5852.2 5396.0 5402.8 5409.2 5416.7 5417.5 5430.5 5476.4 5480.1 5509.2 5522.4 5399.4 5466.7 5484.5 5489.6 5544.2 5347.9 5365.6 5368.8 5372.9 5383.2 5222.1 5252.5 5258.6 5318.9 5321.9 5351.9 5362.9 5388.0 5431.7 5440.0 5281.7 5296.8 5299.0 5299.9 5301.2 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#1] ext.html Cycles:180 Average:45943.75 Median:37048.13 stddev:79371.79 (214.2%) stddev-sans-first:79521.11 14:24:12 INFO - PROCESS | 24618 | Values: 500.3 513.8 518.8 524.6 546.2 29073.3 29578.4 29637.7 29653.7 36936.4 40662.8 40984.4 41104.4 41195.8 41300.8 8393.0 8606.0 8608.5 8609.3 8614.5 8396.3 8498.8 8505.1 8547.9 8553.1 8516.2 8605.4 8612.1 8614.7 8808.6 8623.6 8703.8 8708.7 8715.8 8723.9 8545.2 8690.9 8692.9 8697.0 8703.0 39406.4 39674.8 39702.2 39784.8 39799.0 3219.7 3222.8 3249.2 3264.8 3656.3 29920.0 30091.8 30131.8 30251.7 31181.2 3953.7 3964.9 3992.2 4028.6 4190.9 256632.0 256795.0 257035.0 257185.7 257827.0 53014.0 53890.7 58198.0 59602.0 60830.7 54977.5 55177.7 55264.7 55270.0 55447.4 13692.5 14330.9 14555.7 14567.3 14579.3 9473.6 11064.8 11162.8 11215.3 11242.4 18819.0 19007.5 19012.4 19385.7 19577.2 7316.9 7482.2 7522.5 7587.2 7657.6 862.4 934.8 940.3 1006.6 1015.4 27735.0 27812.3 27847.9 27877.2 27898.3 995.8 1001.8 1028.3 1050.8 1146.7 12634.2 12883.3 13071.8 13129.9 13169.5 300185.0 305160.0 305820.0 306634.0 307152.0 50013.0 50438.4 50450.5 50582.5 50589.0 1123.8 1236.6 1329.6 1356.6 1381.0 24874.8 25176.0 25757.2 25793.1 27458.7 43493.6 43502.6 43866.6 43979.3 43989.6 276174.0 280840.0 371928.0 375445.0 378811.0 30631.8 30762.5 30782.0 30782.1 30782.5 42950.8 42971.4 43372.3 44164.1 44368.3 36709.4 36751.4 37539.6 37546.6 38134.0 36857.4 36954.0 37142.3 37453.4 37828.6 33190.0 33421.3 33740.5 33809.5 34183.1 28217.7 29326.7 30074.4 31710.2 32974.8 20558.9 20683.9 20894.6 20983.3 21924.5 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#2] jquery.html Cycles:180 Average:26501.61 Median:5344.47 stddev:84028.63 (1572.3%) stddev-sans-first:84241.42 14:24:12 INFO - PROCESS | 24618 | Values: 360.8 362.8 363.8 366.4 368.0 13518.7 13617.2 15942.4 16756.2 17742.5 15050.5 15159.4 15510.6 15828.5 15833.8 5146.2 5340.2 5342.1 5346.8 5346.9 3940.6 4041.3 4716.7 5431.5 5727.1 5721.9 5891.6 5939.2 5942.0 5943.4 5782.0 5810.0 5830.2 5838.7 5841.7 4976.9 5152.7 5153.9 5184.4 5189.7 19085.3 19344.8 19540.5 19684.6 19694.1 1970.2 2043.1 2055.6 2137.8 2170.4 11935.0 12389.0 12610.4 12729.0 12729.1 1761.4 1811.2 1832.7 1864.4 1891.7 53911.0 54203.0 54305.5 55132.4 55258.2 9476.5 9585.3 9680.5 9709.7 9766.1 12782.7 12911.5 12919.3 12927.7 12931.5 7018.9 7050.9 7054.1 7102.1 7123.0 6658.3 6679.9 6740.6 6756.1 6769.9 5706.6 5778.7 5820.6 5861.8 5914.1 1647.6 1678.1 1716.0 1721.4 1751.4 920.2 921.0 924.4 978.6 983.2 15738.6 15955.8 16099.3 16412.7 16536.9 823.4 854.1 897.7 971.9 980.9 8697.8 8944.0 8954.3 9001.8 9010.7 508149.0 511240.0 514195.0 518563.0 520119.0 67002.3 72206.0 73488.0 73737.6 74492.5 1080.6 1109.1 1118.5 1119.5 1125.7 13332.0 14500.6 14519.3 14620.7 15069.5 30511.5 30792.8 30853.5 31600.8 31916.4 39033.4 39174.4 39181.0 39212.0 39253.4 6891.2 6944.1 7027.4 7113.2 7212.4 9070.3 10861.6 11066.1 11105.1 11211.9 9102.0 9232.3 9360.2 9579.4 9734.5 9164.6 9327.2 9588.5 9749.1 10031.4 9286.5 9387.8 9666.5 9725.2 9842.3 6147.2 6203.7 6973.2 7150.6 7296.7 8836.9 8935.9 9234.8 9262.4 9353.3 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#3] mootools.html Cycles:180 Average:5421.19 Median:6313.51 stddev:2818.75 (44.6%) stddev-sans-first:2809.65 14:24:12 INFO - PROCESS | 24618 | Values: 1302.1 1448.1 1463.8 1595.5 1779.8 7001.2 7634.4 7689.1 7759.5 7760.3 7703.8 7737.7 7757.5 7766.3 7773.7 2315.5 2335.6 2336.3 2336.9 2339.5 2304.9 2307.1 2345.8 2352.1 2361.4 2342.8 2366.3 2369.5 2370.3 2372.3 2332.2 2363.1 2363.5 2370.3 2371.9 2361.3 2363.6 2364.2 2364.3 2366.4 7755.3 7935.2 7942.1 7965.1 7987.1 4801.5 4882.7 4893.8 4908.1 4911.7 3043.6 3085.9 3120.4 3123.6 3173.1 992.3 1014.6 1039.5 1046.7 1072.1 10470.4 10539.1 10553.1 10559.7 10559.7 4235.7 4259.3 4336.1 4450.4 4455.4 8768.1 8819.9 8822.3 8824.6 8843.0 4955.6 4960.5 4960.9 4967.9 4968.0 4017.4 4082.1 4406.1 4453.2 4529.5 3570.4 3607.7 3611.3 3629.9 3636.1 1029.7 1112.5 1118.9 1125.7 1129.7 1020.1 1056.9 1106.5 1159.2 1289.7 7073.8 7181.9 7211.7 7219.7 7241.2 626.9 636.1 638.7 644.5 777.3 5195.9 5220.7 5318.4 5443.2 5528.8 9227.0 9476.0 9551.4 9557.2 9585.9 9344.8 9378.8 9416.8 9615.6 9668.1 7399.9 7476.7 7523.1 7536.2 7556.4 6843.9 6868.6 6890.2 6960.5 6975.2 8534.7 8602.5 8672.3 8732.7 8754.6 8699.2 8937.3 8970.6 9046.7 9047.7 6428.5 6485.4 6488.6 6491.3 6495.9 7214.1 7353.3 7362.6 7392.9 7461.3 6481.4 6892.1 7043.9 7063.7 7084.0 6643.6 6827.4 6894.0 6967.0 6993.8 6297.9 6303.4 6304.9 6311.3 6315.7 6311.1 6367.9 6381.1 6383.1 6385.8 6308.1 6349.7 6405.6 6418.1 6450.3 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#4] prototype.html Cycles:180 Average:5178.03 Median:5836.74 stddev:1548.15 (26.5%) stddev-sans-first:1509.03 14:24:12 INFO - PROCESS | 24618 | Values: 325.0 334.8 350.3 352.4 362.4 5791.3 5830.2 5843.3 5857.2 5897.9 5543.1 5570.4 5697.3 5774.0 5790.2 4520.3 4531.7 4541.8 4551.1 4554.7 4331.4 4542.0 4556.8 4557.5 4561.0 4350.3 4373.9 4426.8 4428.4 4488.2 4460.8 4463.6 4467.2 4474.2 4493.3 3927.5 3928.7 3929.5 3932.3 3936.8 5384.8 5505.8 5517.8 5519.6 5524.5 5163.8 5166.1 5167.8 5169.4 5176.1 6109.9 6111.6 6112.0 6115.4 6118.4 4305.2 4317.9 4322.3 4329.9 4337.1 6282.2 6401.7 6409.6 6421.1 6425.1 4343.2 4358.5 4363.2 4363.8 4367.1 4371.1 4416.1 4418.8 4422.8 4423.9 5095.2 5119.3 5120.8 5126.6 5127.7 5981.6 6170.0 6174.8 6181.5 6181.6 1596.8 1614.5 1627.5 1630.7 1632.2 1112.7 1123.5 1124.1 1143.9 1144.8 5883.5 5884.4 5884.7 5892.3 5898.1 6347.3 6349.9 6358.6 6364.1 6365.3 5674.2 5742.0 5817.6 5824.9 5844.2 3374.3 3381.1 3395.9 3402.4 3407.6 6620.9 6677.3 6682.8 6721.0 6759.9 6375.5 6502.2 6509.8 6559.7 6575.6 6667.8 6672.5 6684.2 6691.6 6698.6 6365.1 6393.2 6406.5 6417.5 6417.7 6121.4 6322.4 6338.8 6349.1 6351.2 6671.5 6677.5 6688.8 6691.0 6694.5 4423.2 4462.7 4464.4 4465.9 4467.3 6242.7 6389.5 6394.8 6399.6 6405.2 6208.8 6232.3 6234.9 6236.5 6237.5 6244.1 6245.8 6245.8 6249.0 6259.5 5863.6 6097.1 6110.1 6112.5 6117.4 6244.0 6251.2 6251.5 6253.4 6254.1 6123.1 6126.0 6127.5 6129.9 6132.9 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - PROCESS | 24618 | [#5] yui.html Cycles:180 Average:13428.52 Median:45347.00 stddev:15534.21 (34.3%) stddev-sans-first:15548.63 14:24:12 INFO - PROCESS | 24618 | Values: 753.2 814.5 847.9 853.4 875.4 13440.1 13543.7 13584.7 13634.3 13640.9 12223.3 12269.7 12278.0 12282.4 12290.6 650.0 662.5 785.4 807.8 809.2 819.4 830.6 833.1 833.4 833.6 674.9 859.9 862.6 863.7 863.8 694.5 840.5 861.1 862.5 864.3 629.4 630.5 632.0 632.0 632.4 13122.5 13137.7 13186.1 13228.6 13235.0 12544.5 12588.3 12671.4 12914.2 13184.4 10064.5 10128.2 10208.1 10494.3 10587.4 3565.3 3651.4 3664.2 3669.9 3740.6 44721.1 44857.3 45331.0 45363.0 45558.5 9372.9 9481.9 9692.1 9920.2 9984.3 17049.0 17090.7 17110.5 17118.1 17763.8 7801.5 7871.2 7909.0 7946.4 8166.1 4420.6 4465.4 4515.7 4533.8 4546.8 3048.8 3056.3 3082.7 3102.3 3108.6 562.4 578.7 591.6 595.2 620.3 612.3 636.9 654.2 684.1 697.3 7906.0 9060.0 9095.7 9218.6 9294.3 523.8 567.2 640.9 666.0 689.7 3939.0 3946.3 4134.8 4162.5 4162.8 59048.0 59992.4 60122.4 60338.0 60417.1 47453.0 47832.5 48338.5 48471.0 48934.5 43363.8 43590.0 43792.3 43952.0 44525.0 8249.6 8346.9 8412.5 8461.2 8512.2 34141.0 34165.8 34764.8 35326.6 35375.6 39997.4 41706.4 43850.0 43904.6 44214.8 11009.5 11066.0 11102.8 11337.0 11652.9 11278.3 11375.5 11411.8 11611.9 12000.4 9894.2 10006.2 10207.5 10322.8 10377.1 10710.8 11330.2 11387.5 11409.1 11805.7 10605.4 10621.7 10624.1 10661.3 10941.7 8822.9 9057.2 9460.2 9467.6 9470.6 7969.2 8257.9 8364.3 8462.0 9033.2 14:24:12 INFO - PROCESS | 24618 | -------- Summary: end -------- 14:24:12 INFO - PROCESS | 24618 | 14:24:12 INFO - TEST-INFO | 24618: exit 0 14:24:12 INFO - TEST-OK | dromaeo_css | took 1111544ms 14:24:12 INFO - TEST-START | kraken 14:24:12 INFO - operating with platform_type : linux_ 14:24:12 INFO - Initialising browser for kraken test... 14:24:12 INFO - TEST-INFO | started process 24814 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXML9vS/profile http://localhost:51221/getInfo.html) 14:24:16 INFO - PROCESS | 24814 | __metrics Screen width/height:1600/1200 14:24:16 INFO - PROCESS | 24814 | colorDepth:24 14:24:16 INFO - PROCESS | 24814 | Browser inner width/height: 1024/697 14:24:16 INFO - PROCESS | 24814 | __metrics 14:24:16 INFO - PROCESS | 24814 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:24:16 INFO - PROCESS | 24814 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:17 INFO - TEST-INFO | 24814: exit 0 14:24:17 INFO - Browser initialized. 14:24:17 INFO - Running cycle 1/1 for kraken test... 14:24:17 INFO - TEST-INFO | started process 24895 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXML9vS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:29 INFO - PROCESS | 24895 | RSS: Main: 148271104 14:24:29 INFO - PROCESS | 24895 | 14:24:31 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51221/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:32 INFO - PROCESS | 24895 | RSS: Main: 184594432 14:24:32 INFO - PROCESS | 24895 | 14:24:34 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51221/tests/kraken/driver.html?testName=audio-dft) 14:24:35 INFO - PROCESS | 24895 | RSS: Main: 174477312 14:24:35 INFO - PROCESS | 24895 | 14:24:38 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51221/tests/kraken/driver.html?testName=audio-fft) 14:24:38 INFO - PROCESS | 24895 | RSS: Main: 158273536 14:24:38 INFO - PROCESS | 24895 | 14:24:40 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51221/tests/kraken/driver.html?testName=audio-oscillator) 14:24:41 INFO - PROCESS | 24895 | RSS: Main: 161189888 14:24:41 INFO - PROCESS | 24895 | 14:24:43 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51221/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:44 INFO - PROCESS | 24895 | RSS: Main: 163024896 14:24:44 INFO - PROCESS | 24895 | 14:24:47 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51221/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:47 INFO - PROCESS | 24895 | RSS: Main: 165023744 14:24:47 INFO - PROCESS | 24895 | 14:24:51 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51221/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:51 INFO - PROCESS | 24895 | RSS: Main: 165076992 14:24:51 INFO - PROCESS | 24895 | 14:24:54 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51221/tests/kraken/driver.html?testName=json-parse-financial) 14:24:55 INFO - PROCESS | 24895 | RSS: Main: 164429824 14:24:55 INFO - PROCESS | 24895 | 14:24:56 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51221/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:57 INFO - PROCESS | 24895 | RSS: Main: 176390144 14:24:57 INFO - PROCESS | 24895 | 14:24:58 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:59 INFO - PROCESS | 24895 | RSS: Main: 173613056 14:24:59 INFO - PROCESS | 24895 | 14:25:01 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:02 INFO - PROCESS | 24895 | RSS: Main: 186990592 14:25:02 INFO - PROCESS | 24895 | 14:25:04 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:05 INFO - PROCESS | 24895 | RSS: Main: 192311296 14:25:05 INFO - PROCESS | 24895 | 14:25:07 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:08 INFO - PROCESS | 24895 | RSS: Main: 190021632 14:25:08 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | Cycle 1(1): loaded http://localhost:51221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51221/tests/kraken/driver.html?testName=ai-astar) 14:25:10 INFO - PROCESS | 24895 | RSS: Main: 248758272 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | __start_tp_report 14:25:10 INFO - PROCESS | 24895 | _x_x_mozilla_page_load 14:25:10 INFO - PROCESS | 24895 | _x_x_mozilla_page_load_details 14:25:10 INFO - PROCESS | 24895 | |i|pagename|runs| 14:25:10 INFO - PROCESS | 24895 | |0;ai-astar;108;110;103;110;111;110;101;109;109;117 14:25:10 INFO - PROCESS | 24895 | |1;audio-beat-detection;151;126;150;162;124;150;152;123;176;126 14:25:10 INFO - PROCESS | 24895 | |2;audio-dft;160;161;161;160;161;161;159;163;160;160 14:25:10 INFO - PROCESS | 24895 | |3;audio-fft;72;73;85;93;74;75;72;105;96;73 14:25:10 INFO - PROCESS | 24895 | |4;audio-oscillator;96;96;143;96;96;96;135;95;97;144 14:25:10 INFO - PROCESS | 24895 | |5;imaging-gaussian-blur;110;110;109;110;109;109;109;110;109;110 14:25:10 INFO - PROCESS | 24895 | |6;imaging-darkroom;145;146;146;145;145;146;145;145;146;147 14:25:10 INFO - PROCESS | 24895 | |7;imaging-desaturate;95;95;95;96;96;96;96;95;96;96 14:25:10 INFO - PROCESS | 24895 | |8;json-parse-financial;54;55;55;55;55;56;57;65;53;53 14:25:10 INFO - PROCESS | 24895 | |9;json-stringify-tinderbox;66;68;67;67;74;69;67;67;66;67 14:25:10 INFO - PROCESS | 24895 | |10;stanford-crypto-aes;92;86;88;85;86;87;85;91;87;86 14:25:10 INFO - PROCESS | 24895 | |11;stanford-crypto-ccm;116;115;124;132;117;121;124;122;126;116 14:25:10 INFO - PROCESS | 24895 | |12;stanford-crypto-pbkdf2;142;141;149;148;151;141;149;151;147;141 14:25:10 INFO - PROCESS | 24895 | |13;stanford-crypto-sha256-iterative;68;70;70;67;69;68;68;68;69;66 14:25:10 INFO - PROCESS | 24895 | __end_tp_report 14:25:10 INFO - PROCESS | 24895 | __start_cc_report 14:25:10 INFO - PROCESS | 24895 | _x_x_mozilla_cycle_collect,955 14:25:10 INFO - PROCESS | 24895 | __end_cc_report 14:25:10 INFO - PROCESS | 24895 | __startTimestamp1452637510283__endTimestamp 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | ------- Summary: start ------- 14:25:10 INFO - PROCESS | 24895 | Number of tests: 14 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:4.37 (4.0%) stddev-sans-first:4.62 14:25:10 INFO - PROCESS | 24895 | Values: 108.0 110.0 103.0 110.0 111.0 110.0 101.0 109.0 109.0 117.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.50 stddev:18.32 (12.2%) stddev-sans-first:19.26 14:25:10 INFO - PROCESS | 24895 | Values: 151.0 126.0 150.0 162.0 124.0 150.0 152.0 123.0 176.0 126.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 14:25:10 INFO - PROCESS | 24895 | Values: 160.0 161.0 161.0 160.0 161.0 161.0 159.0 163.0 160.0 160.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.50 stddev:12.15 (16.3%) stddev-sans-first:12.36 14:25:10 INFO - PROCESS | 24895 | Values: 72.0 73.0 85.0 93.0 74.0 75.0 72.0 105.0 96.0 73.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.71 (22.6%) stddev-sans-first:22.47 14:25:10 INFO - PROCESS | 24895 | Values: 96.0 96.0 143.0 96.0 96.0 96.0 135.0 95.0 97.0 144.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:25:10 INFO - PROCESS | 24895 | Values: 110.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 14:25:10 INFO - PROCESS | 24895 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 147.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:25:10 INFO - PROCESS | 24895 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.46 (6.3%) stddev-sans-first:3.61 14:25:10 INFO - PROCESS | 24895 | Values: 54.0 55.0 55.0 55.0 55.0 56.0 57.0 65.0 53.0 53.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.00 stddev:2.35 (3.5%) stddev-sans-first:2.40 14:25:10 INFO - PROCESS | 24895 | Values: 66.0 68.0 67.0 67.0 74.0 69.0 67.0 67.0 66.0 67.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:2.41 (2.8%) stddev-sans-first:1.86 14:25:10 INFO - PROCESS | 24895 | Values: 92.0 86.0 88.0 85.0 86.0 87.0 85.0 91.0 87.0 86.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:123.00 stddev:5.44 (4.4%) stddev-sans-first:5.42 14:25:10 INFO - PROCESS | 24895 | Values: 116.0 115.0 124.0 132.0 117.0 121.0 124.0 122.0 126.0 116.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.50 stddev:4.27 (2.9%) stddev-sans-first:4.28 14:25:10 INFO - PROCESS | 24895 | Values: 142.0 141.0 149.0 148.0 151.0 141.0 149.0 151.0 147.0 141.0 14:25:10 INFO - PROCESS | 24895 | 14:25:10 INFO - PROCESS | 24895 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 14:25:10 INFO - PROCESS | 24895 | Values: 68.0 70.0 70.0 67.0 69.0 68.0 68.0 68.0 69.0 66.0 14:25:10 INFO - PROCESS | 24895 | -------- Summary: end -------- 14:25:10 INFO - PROCESS | 24895 | 14:25:11 INFO - TEST-INFO | 24895: exit 0 14:25:11 INFO - TEST-OK | kraken | took 58380ms 14:25:11 INFO - TEST-START | v8_7 14:25:11 INFO - operating with platform_type : linux_ 14:25:11 INFO - Initialising browser for v8_7 test... 14:25:11 INFO - TEST-INFO | started process 25143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp909Au3/profile http://localhost:51221/getInfo.html) 14:25:15 INFO - PROCESS | 25143 | __metrics Screen width/height:1600/1200 14:25:15 INFO - PROCESS | 25143 | colorDepth:24 14:25:15 INFO - PROCESS | 25143 | Browser inner width/height: 1024/697 14:25:15 INFO - PROCESS | 25143 | __metrics 14:25:15 INFO - PROCESS | 25143 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:25:15 INFO - PROCESS | 25143 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:25:16 INFO - TEST-INFO | 25143: exit 0 14:25:16 INFO - Browser initialized. 14:25:16 INFO - Running cycle 1/1 for v8_7 test... 14:25:16 INFO - TEST-INFO | started process 25227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp909Au3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:27 INFO - PROCESS | 25227 | RSS: Main: 148541440 14:25:27 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | Cycle 1(1): loaded http://localhost:51221/tests/v8_7/run.html (next: http://localhost:51221/tests/v8_7/run.html) 14:25:50 INFO - PROCESS | 25227 | RSS: Main: 568569856 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | __start_tp_report 14:25:50 INFO - PROCESS | 25227 | _x_x_mozilla_page_load 14:25:50 INFO - PROCESS | 25227 | _x_x_mozilla_page_load_details 14:25:50 INFO - PROCESS | 25227 | |i|pagename|runs| 14:25:50 INFO - PROCESS | 25227 | |0;Richards;165.39861065167054 14:25:50 INFO - PROCESS | 25227 | |1;DeltaBlue;190.94901661256444 14:25:50 INFO - PROCESS | 25227 | |2;Encrypt;281.0567734682406 14:25:50 INFO - PROCESS | 25227 | |3;Decrypt;5256.544502617801 14:25:50 INFO - PROCESS | 25227 | |4;RayTrace;1984.126984126984 14:25:50 INFO - PROCESS | 25227 | |5;Earley;769.2307692307693 14:25:50 INFO - PROCESS | 25227 | |6;Boyer;12292.682926829268 14:25:50 INFO - PROCESS | 25227 | |7;RegExp;41489.795918367345 14:25:50 INFO - PROCESS | 25227 | |8;Splay;574.9427917620137 14:25:50 INFO - PROCESS | 25227 | |9;NavierStokes;4830.917874396136 14:25:50 INFO - PROCESS | 25227 | __end_tp_report 14:25:50 INFO - PROCESS | 25227 | __startTimestamp1452637550520__endTimestamp 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | ------- Summary: start ------- 14:25:50 INFO - PROCESS | 25227 | Number of tests: 10 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#0] Richards Cycles:1 Average:165.40 Median:165.40 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 165.4 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 190.9 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 281.1 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 5256.5 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 1984.1 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#5] Earley Cycles:1 Average:769.23 Median:769.23 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 769.2 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 12292.7 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#7] RegExp Cycles:1 Average:41489.80 Median:41489.80 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 41489.8 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#8] Splay Cycles:1 Average:574.94 Median:574.94 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 574.9 14:25:50 INFO - PROCESS | 25227 | 14:25:50 INFO - PROCESS | 25227 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:25:50 INFO - PROCESS | 25227 | Values: 4830.9 14:25:50 INFO - PROCESS | 25227 | -------- Summary: end -------- 14:25:50 INFO - PROCESS | 25227 | 14:25:51 INFO - TEST-INFO | 25227: exit 0 14:25:51 INFO - TEST-OK | v8_7 | took 40197ms 14:25:51 INFO - SUITE-END | took 1210s 14:25:51 INFO - Completed test suite (00:20:10) 14:25:51 INFO - Working with test: dromaeo_css 14:25:51 INFO - Generating results file: dromaeo_css 14:25:51 INFO - Working with test: kraken 14:25:51 INFO - Generating results file: kraken 14:25:51 INFO - javascript benchmark 14:25:51 INFO - Working with test: v8_7 14:25:51 INFO - Generating results file: v8_7 14:25:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:25:51 INFO - process_Request line: dromaeo_css 6739.28 graph.html#tests=[[72,64,35]] 14:25:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:51 INFO - process_Request line: kraken 1501.80 graph.html#tests=[[232,64,35]] 14:25:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:51 INFO - process_Request line: v8_7 19038.75 graph.html#tests=[[230,64,35]] 14:25:51 INFO - RETURN: dromaeo_css: 6739.28 14:25:51 INFO - RETURN: kraken: 1501.80 14:25:51 INFO - RETURN: v8_7: 19038.75 14:25:51 INFO - javascript benchmark 14:25:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3145.779795414321, 3162.8576714047867, 3198.9840050799758, 3203.3273012667323, 3222.7421806255493, 5065.062963351783, 5132.050570644429, 5149.485051494853, 5165.147750621143, 5190.169572868342, 5158.742062896849, 5194.584433245341, 5199.558037566811, 5229.0, 5324.201369794533, 4565.2467342888385, 4677.602403795681, 4713.457952335491, 4776.8566942991765, 4837.129316722989, 4794.880127996793, 4803.759812009385, 4823.782929768169, 4879.316895634596, 4901.387326584177, 4662.393888794452, 4683.039976804781, 4723.4331880174595, 4730.668853180296, 4759.7620118994255, 4683.180443422388, 4702.059588082363, 4705.294205869112, 4719.882002949919, 4754.477007529169, 4629.166749985001, 4669.276262179334, 4681.765911704401, 4700.106979673851, 4735.455422626407, 5026.145555255615, 5033.471485494044, 5080.060188865072, 5084.415292241402, 5089.44016158226, 5494.0, 5501.422350653163, 5501.834944951658, 5503.11950087988, 5506.311711036121, 5507.752151153168, 5531.695756733378, 5545.916811247835, 5585.078462053756, 5587.664740115565, 5113.156329205676, 5195.844124676228, 5222.451642577551, 5223.686578805284, 5265.104932161542, 5648.802291919763, 5651.0675738503505, 5652.18043383707, 5655.5475561954945, 5657.915131273035, 5374.543163831118, 5425.728713564306, 5430.402655707869, 5436.184572314184, 5436.864078398072, 5475.370332411823, 5476.972615136899, 5498.505134537911, 5503.367112782082, 5525.889482210333, 5421.430749771217, 5429.131338985743, 5437.211604317352, 5440.591955603267, 5443.972780136074, 5384.91922621161, 5431.2667789847865, 5435.10320797064, 5483.287172667608, 5516.338039435213, 4331.306990881444, 4333.6316413104605, 4336.609705126553, 4367.847125350598, 4374.737515749065, 3840.1551658635058, 3862.0344913771555, 3869.1294458746556, 3901.1027463683513, 3906.121122747359, 5126.743662816919, 5167.22491626259, 5177.948220517822, 5180.585553155738, 5182.6372153949615, 5481.671099734029, 5519.475649813261, 5519.69641669704, 5542.0, 5546.861328466821, 5127.128388174019, 5161.535461808456, 5171.50870667286, 5174.482551744795, 5225.973870130625, 4694.342792009122, 4717.8348757794, 4754.7147171169845, 4780.306855505932, 4859.781309840995, 5655.717214139277, 5659.858503537444, 5664.405237450091, 5667.1499275108235, 5685.886282274331, 5445.59158063139, 5449.3460784706085, 5454.672719636835, 5462.3445186577865, 5503.449655034465, 5665.065264231355, 5736.799212027726, 5774.047282198559, 5802.738876750472, 5852.18069470266, 5396.028714831211, 5402.783888644411, 5409.242706021081, 5416.674999499885, 5417.539509141767, 5430.456954304696, 5476.397596264328, 5480.095784195563, 5509.173623956439, 5522.447755224445, 5399.352077750538, 5466.699331536644, 5484.451554844483, 5489.58828087887, 5544.168374743821, 5347.866303342447, 5365.624406291522, 5368.785248590013, 5372.946270537401, 5383.192521121863, 5222.060029194781, 5252.527272545489, 5258.605604579595, 5318.8936221276135, 5321.9467805323, 5351.892962140658, 5362.892742145214, 5387.973060134675, 5431.728413579384, 5440.047991601533, 5281.683099014072, 5296.761645725875, 5298.993191293642, 5299.894002119859, 5301.1518157096225], "unit": "score", "name": "dojo.html", "value": 5101.744960248269}, {"lowerIsBetter": false, "replicates": [500.29708259894835, 513.7944822071169, 518.846940152655, 524.569852720769, 546.1507356061325, 29073.273168170806, 29578.408431831405, 29637.703622963763, 29653.70346296539, 36936.44595331072, 40662.796686016525, 40984.38523422151, 41104.38343424851, 41195.79402102993, 41300.79349603248, 8393.0, 8606.0, 8608.52653104079, 8609.26821220194, 8614.483131012128, 8396.328293736486, 8498.787530311762, 8505.064442911274, 8547.914520854805, 8553.144685531459, 8516.23353898149, 8605.39762216645, 8612.09572994836, 8614.698485553006, 8808.64765409383, 8623.611937462798, 8703.782405439852, 8708.738737837875, 8715.825683486359, 8723.869141962843, 8545.188207120314, 8690.913635795525, 8692.869606955901, 8697.043325234219, 8702.956485217534, 39406.40890386647, 39674.801625991975, 39702.20595588101, 39784.80107599472, 39799.0, 3219.7263232625255, 3222.822744749038, 3249.155219642886, 3264.836758162106, 3656.2687462507606, 29920.0, 30091.849540752373, 30131.849340753375, 30251.69748302511, 31181.220469488217, 3953.6639385652256, 3964.940525892114, 3992.161646054332, 4028.637422631977, 4190.895227619303, 256632.0, 256795.0, 257034.99999999814, 257185.71407143032, 257827.0, 53014.0, 53890.730546347804, 58198.0, 59602.0, 60830.69584652048, 54977.45022549803, 55177.72411137919, 55264.72367638136, 55270.0, 55447.44552554504, 13692.452301908012, 14330.928345358416, 14555.671092625129, 14567.344469498687, 14579.271036448135, 9473.621055157717, 11064.834027489595, 11162.776744465227, 11215.271007384494, 11242.38166900812, 18819.0, 19007.524811879535, 19012.429627111207, 19385.709214361796, 19577.216911323387, 7316.926830731731, 7482.176960534337, 7522.504386553584, 7587.2412758723685, 7657.578833164118, 862.3920136303891, 934.8364036293622, 940.3182692547848, 1006.5571148694551, 1015.4465816130227, 27735.0, 27812.30469238285, 27847.86236490779, 27877.16368508948, 27898.302542436195, 995.8257304971601, 1001.8397056471075, 1028.3264461777549, 1050.810854046279, 1146.7419830538063, 12634.178778379375, 12883.33797382762, 13071.803922941164, 13129.868701313055, 13169.53906613264, 300185.0, 305160.0, 305820.0, 306634.0, 307152.0, 50013.0, 50438.443002409454, 50450.49549504531, 50582.49417505851, 50589.0, 1123.8482804821408, 1236.6228300368473, 1329.5811819276896, 1356.620146359021, 1381.0470775165104, 24874.751252487244, 25176.0, 25757.227283181535, 25793.097241596453, 27458.725412746415, 43493.56506434895, 43502.56497435112, 43866.56133438752, 43979.34030989474, 43989.560104398544, 276174.0, 280840.0, 371928.0, 375445.0, 378811.0, 30631.846840765655, 30762.53856192114, 30782.0, 30782.076537703906, 30782.538261926537, 42950.78524607357, 42971.3554296692, 43372.34941475943, 44164.11671766611, 44368.33447498226, 36709.44935826018, 36751.448728268566, 37539.62460375361, 37546.624533754315, 38134.0, 36857.447138293486, 36954.01120848759, 37142.25715485621, 37453.4381984265, 37828.621713783614, 33190.0, 33421.33157336888, 33740.49389259212, 33809.49285760667, 34183.14542136367, 28217.71782282151, 29326.70673293325, 30074.398512030075, 31710.152737651097, 32974.83512582422, 20558.897205513877, 20683.896580517605, 20894.61908990385, 20983.265585704426, 21924.45188870227], "unit": "score", "name": "ext.html", "value": 17781.052984993883}, {"lowerIsBetter": false, "replicates": [360.79074137000543, 362.83309677548345, 363.79263819622815, 366.3680151738251, 367.99632003679955, 13518.662033449169, 13617.182969021866, 15942.36230550778, 16756.2459689314, 17742.46772596821, 15050.548483545484, 15159.393624255017, 15510.612234694137, 15828.525144245663, 15833.841661583381, 5146.176611742113, 5340.225667278242, 5342.118550439173, 5346.812861549846, 5346.893062138755, 3940.6453419192267, 4041.312976793937, 4716.669833111667, 5431.456854314576, 5727.083666613343, 5721.8569535761735, 5891.58758886876, 5939.168516407706, 5942.0, 5943.375945525722, 5781.971090144564, 5810.041343178371, 5830.212921255661, 5838.678872662002, 5841.678707671076, 4976.850694479172, 5152.742362881841, 5153.948460515385, 5184.377874655065, 5189.7405129743365, 19085.332013379466, 19344.80655193444, 19540.511487212792, 19684.606307873906, 19694.113764880472, 1970.1528342812585, 2043.1010355443707, 2055.5580550181785, 2137.7648458669532, 2170.4031391367344, 11935.0, 12389.0, 12610.432530536056, 12729.0, 12729.108962372638, 1761.4363403710818, 1811.157811617591, 1832.6792811257976, 1864.4313484387255, 1891.6689579323702, 53911.0, 54203.0, 54305.45694543044, 55132.44867551313, 55258.17112743312, 9476.526173691287, 9585.281103917094, 9680.46757428334, 9709.70870873875, 9766.07222313879, 12782.735421532907, 12911.483540658268, 12919.289439080752, 12927.741445171045, 12931.5473958411, 7018.894716579255, 7050.92949070513, 7054.08296921397, 7102.112235970504, 7122.964385178041, 6658.3341665834, 6679.866402672016, 6740.561863478858, 6756.054152418666, 6769.8646027079185, 5706.600537962303, 5778.711064446761, 5820.592558520948, 5861.794837180678, 5914.053751399755, 1647.604574902015, 1678.144146485277, 1715.9914200428918, 1721.3630956545908, 1751.3607533250272, 920.2408013388981, 920.9861852072224, 924.4499522783933, 978.5682578791697, 983.1937810994915, 15738.606534836492, 15955.760663590056, 16099.275532601061, 16412.671746565004, 16536.917315413586, 823.3877799741429, 854.0775961961067, 897.6813231302793, 971.9271054670786, 980.8921018687938, 8697.782555436039, 8943.955280223558, 8954.2836573074, 9001.774955626162, 9010.693449449793, 508149.0, 511240.0, 514195.0, 518563.0, 520119.0, 67002.3299766996, 72206.0, 73488.0, 73737.6313118431, 74492.53044817329, 1080.6325849211148, 1109.1016276815806, 1118.4519585403257, 1119.5130118398522, 1125.6679279612697, 13332.0, 14500.637484062983, 14519.274036298355, 14620.707585848437, 15069.47256846005, 30511.54232686467, 30792.84603576968, 30853.537196941616, 31600.841995789873, 31916.361672766878, 39033.414498781975, 39174.41238381484, 39181.0, 39212.0, 39253.41119883147, 6891.1738389325865, 6944.097267355211, 7027.437804975488, 7113.181984071691, 7212.42300615939, 9070.274378049608, 10861.619843305447, 11066.114710822954, 11105.111591072857, 11211.943940280247, 9101.954490227507, 9232.261419086592, 9360.204382627553, 9579.377340472847, 9734.464604446823, 9164.587593558439, 9327.207187389147, 9588.472634005197, 9749.07383798538, 10031.398116113056, 9286.489243091695, 9387.765305867408, 9666.516674166403, 9725.238787116152, 9842.311038227255, 6147.170132032118, 6203.689815509116, 6973.163220413583, 7150.606716630427, 7296.7446139384865, 8836.867446988172, 8935.865962010705, 9234.769130771785, 9262.39794413361, 9353.298502612195], "unit": "score", "name": "jquery.html", "value": 8053.239500310775}, {"lowerIsBetter": false, "replicates": [1302.1015499305483, 1448.0587618048264, 1463.7511623024084, 1595.5213435969206, 1779.80422153563, 7001.159860816702, 7634.389248860091, 7689.077310722721, 7759.495632783865, 7760.340371068459, 7703.807404814883, 7737.690492380298, 7757.534547927128, 7766.262205090521, 7773.68905243791, 2315.525317309952, 2335.602947498929, 2336.334144768741, 2336.901656221573, 2339.508703172336, 2304.9078036878504, 2307.1232931486097, 2345.7771511706446, 2352.0709319818748, 2361.4332560185517, 2342.812574994005, 2366.2782851230368, 2369.5497855407502, 2370.277065495023, 2372.323887692008, 2332.207049603143, 2363.0665886974634, 2363.527294541099, 2370.2533701883935, 2371.893264803088, 2361.303415492434, 2363.645453182019, 2364.160722943365, 2364.3498038039506, 2366.372911178539, 7755.302022817917, 7935.2064793520185, 7942.086660034112, 7965.084015338252, 7987.121416644164, 4801.4718380978065, 4882.731449770261, 4893.755312234374, 4908.067467181224, 4911.705297682151, 3043.6195475565555, 3085.861136248874, 3120.3603261331373, 3123.593932788746, 3173.1273899677544, 992.3103443107043, 1014.5890914179769, 1039.5270152080784, 1046.670298855858, 1072.0940805019745, 10470.371777693286, 10539.051485366277, 10553.050225479743, 10559.68320950365, 10559.736006599896, 4235.682323825726, 4259.27592309302, 4336.067745434747, 4450.35469856869, 4455.398521199597, 8768.07935166811, 8819.867701984474, 8822.338324625678, 8824.602892869836, 8843.027267000625, 4955.554000140005, 4960.479149689303, 4960.925586116211, 4967.925481117786, 4968.031233909425, 4017.4375587417785, 4082.081531655413, 4406.140802543473, 4453.198424283595, 4529.456465224194, 3570.393033184365, 3607.6933460656137, 3611.3138503684218, 3629.872954446582, 3636.1455058061333, 1029.6602121299952, 1112.5494174859195, 1118.8881111888745, 1125.662301309604, 1129.6780417581115, 1020.1430798129459, 1056.9260151789301, 1106.4633652678444, 1159.1596092832797, 1289.6775806048488, 7073.752418665322, 7181.856362872818, 7211.675474603656, 7219.675114619749, 7241.203467618558, 626.9467095296951, 636.0745115856417, 638.6710843915388, 644.4972921121532, 777.2693667952107, 5195.948040519622, 5220.738963051832, 5318.388385335658, 5443.183522471581, 5528.75120619573, 9227.016191518856, 9476.0, 9551.42691438502, 9557.23542116629, 9585.856212156823, 9344.813103737888, 9378.765530861783, 9416.811663766686, 9615.56729947154, 9668.129868311886, 7399.889001664979, 7476.70093196277, 7523.134839493418, 7536.171021187665, 7556.433267504959, 6843.8973415399805, 6868.553544019623, 6890.173179218526, 6960.512764106464, 6975.197852247056, 8534.70128545498, 8602.483850968962, 8672.349573781865, 8732.69435569752, 8754.649814007369, 8699.173578510032, 8937.28501719874, 8970.551472426221, 9046.683366082156, 9047.683331083645, 6428.4857211423905, 6485.383888530582, 6488.578242414228, 6491.318411566906, 6495.935040649533, 7214.062171917617, 7353.301436363537, 7362.595057271901, 7392.8891066635115, 7461.253874612496, 6481.384268494486, 6892.104026476526, 7043.929560704328, 7063.71745130189, 7084.043654106629, 6643.634600096848, 6827.351401616838, 6894.0, 6967.0, 6993.790186294419, 6297.874042519215, 6303.36966303366, 6304.936950630618, 6311.305756366704, 6315.715792789428, 6311.084892690626, 6367.872642547216, 6381.106645069601, 6383.106365108795, 6385.808425747235, 6308.053791931247, 6349.714262858275, 6405.583637063763, 6418.101465794886, 6450.322716114741], "unit": "score", "name": "mootools.html", "value": 4414.2894463716375}, {"lowerIsBetter": false, "replicates": [324.98700051997923, 334.794101627499, 350.346603584315, 352.3745352000199, 362.4346020208475, 5791.276090488689, 5830.154627579004, 5843.328017278014, 5857.209276747638, 5897.882042359151, 5543.085390910505, 5570.415106413819, 5697.344805347387, 5774.0, 5790.218320526727, 4520.321951707254, 4531.682782205238, 4541.772911354436, 4551.089782043588, 4554.681172317939, 4331.3719510670935, 4541.977290113545, 4556.84051058213, 4557.475890272628, 4561.042181141964, 4350.282203436429, 4373.890652733675, 4426.756528390937, 4428.424304840366, 4488.23699971004, 4460.754658493782, 4463.620592249663, 4467.24056910326, 4474.172278128541, 4493.326001099845, 3927.5483319418063, 3928.7446315989655, 3929.5284565851994, 3932.3315036443873, 3936.822842972073, 5384.838454846361, 5505.834824955217, 5517.834464966058, 5519.613627046108, 5524.502794748492, 5163.819266325698, 5166.121759300928, 5167.7674504647, 5169.431362550116, 5176.094183517869, 6109.938900610981, 6111.572189946705, 6112.022076467744, 6115.357887421846, 6118.418750218722, 4305.246581848164, 4317.935230971507, 4322.308430651081, 4329.870103896857, 4337.067530480962, 6282.183316168915, 6401.711922963478, 6409.583377080475, 6421.068945002995, 6425.068365087036, 4343.19650864591, 4358.5205627380965, 4363.214621368184, 4363.847265345697, 4367.082912588392, 4371.082072764755, 4416.050549131952, 4418.779061046935, 4422.778861056934, 4423.933640995388, 5095.235714642833, 5119.257707632372, 5120.846374608767, 5126.641135120506, 5127.717975511383, 5981.581289309794, 6170.0, 6174.783882564178, 6181.474574661114, 6181.567290289637, 1596.8323326050597, 1614.5479265805593, 1627.4954764023191, 1630.722777127891, 1632.2002218912646, 1112.6884472347756, 1123.4607388453587, 1124.1288001798507, 1143.8512993310983, 1144.7824913266452, 5883.499902508334, 5884.411558844081, 5884.735186916599, 5892.263467066617, 5898.14476900847, 6347.301796802348, 6349.8730025400155, 6358.618482891041, 6364.140840986408, 6365.2998170201245, 5674.205611214434, 5741.971290143522, 5817.592768506164, 5824.941750582525, 5844.152597873284, 3374.257663314067, 3381.120908563791, 3395.898123056312, 3402.4385976314124, 3407.5910890693276, 6620.933790662032, 6677.298883617247, 6682.832929176712, 6721.025451309532, 6759.864802703918, 6375.521835862329, 6502.219733631994, 6509.804705858832, 6559.704813283413, 6575.572587781779, 6667.833304167338, 6672.499562532829, 6684.231313398924, 6691.59850408977, 6698.5980841149685, 6365.140706004815, 6393.232812062396, 6406.494473798561, 6417.518686098468, 6417.711202995783, 6121.3878612140215, 6322.399372059647, 6338.809835704937, 6349.07938348946, 6351.237851457855, 6671.532992690465, 6677.499187561049, 6688.83277918056, 6691.0, 6694.4644428444635, 4423.159599676052, 4462.665300102441, 4464.441944756905, 4465.866024019285, 4467.329900514819, 6242.65665388408, 6389.52078594098, 6394.840128996626, 6399.648019358794, 6405.231372235362, 6208.782692605737, 6232.25212974446, 6234.875302494015, 6236.469900058364, 6237.469815065589, 6244.094606282155, 6245.750849830143, 6245.781397651061, 6248.968755156195, 6259.467945224706, 5863.618864773776, 6097.146399504161, 6110.114033465212, 6112.510999119971, 6117.449429551361, 6244.0321750128805, 6251.187345645219, 6251.468625166912, 6253.405926436982, 6254.093156492374, 6123.14276001369, 6126.0, 6127.479164271087, 6129.938700612936, 6132.8773424532155], "unit": "score", "name": "prototype.html", "value": 4687.371772678199}, {"lowerIsBetter": false, "replicates": [753.1790348520112, 814.4543156085422, 847.8558645030345, 853.4239388412819, 875.4047247871445, 13440.126391784526, 13543.661408464794, 13584.660383490418, 13634.250116243602, 13640.931795341034, 12223.266604003766, 12269.693257668563, 12278.0, 12282.385880705951, 12290.631281061582, 649.9512536559753, 662.5130529061137, 785.426638553856, 807.7697856111009, 809.1746418652971, 819.397742659145, 830.5847076461769, 833.0669649992018, 833.3874602167402, 833.5790425834975, 674.8684006618711, 859.8624220124781, 862.5687156421789, 863.6804382378529, 863.7926897544576, 694.4964900447161, 840.5125027484075, 861.1173547114196, 862.4695812075529, 864.2653744317342, 629.3517676792865, 630.5271046714964, 631.9620822750604, 631.9778807741707, 632.4118569730149, 13122.540711075162, 13137.671558211026, 13186.142900711424, 13228.603141905758, 13235.0, 12544.498220071186, 12588.307643079626, 12671.36643167838, 12914.160579562393, 13184.406701698446, 10064.496775161286, 10128.240381971307, 10208.081272685495, 10494.317869338469, 10587.369175056747, 3565.322588708163, 3651.397519409294, 3664.175560498893, 3669.87155449558, 3740.60723624021, 44721.105577888586, 44857.32714009292, 45331.0, 45363.0, 45558.54441455576, 9372.8594071089, 9481.90518094824, 9692.127708506268, 9920.156786673213, 9984.251181161442, 17049.0, 17090.743638845426, 17110.486685399457, 17118.058506782247, 17763.822361776474, 7801.453898227183, 7871.212878712083, 7909.0, 7946.364290856717, 8166.060902996112, 4420.58004489573, 4465.42638134782, 4515.68390212682, 4533.795979180944, 4546.818127274938, 3048.7713421493477, 3056.266496040979, 3082.722554970019, 3102.30198205402, 3108.564800927872, 562.4150883081631, 578.7048605211372, 591.6095377051212, 595.1964847455899, 620.2866703291252, 612.317266248139, 636.9172007638978, 654.1626717801222, 684.1482354468718, 697.3061803505544, 7905.960470197727, 9060.0, 9095.727128186032, 9218.58516366765, 9294.302927280482, 523.7695414017896, 567.1662655895826, 640.9359064093553, 665.9600423974578, 689.6586189836063, 3938.9606103938595, 3946.2896678598127, 4134.772587507716, 4162.500499940026, 4162.791860406967, 59048.0, 59992.400075999554, 60122.39877601255, 60338.0, 60417.09374359388, 47453.0, 47832.5216747835, 48338.5166148341, 48471.0, 48934.510654893, 43363.78318108389, 43590.0, 43792.343114852665, 43952.0, 44525.0, 8249.587520624065, 8346.916530834615, 8412.495250285003, 8461.153884611489, 8512.233898949124, 34141.0, 34165.829170853984, 34764.82617586896, 35326.64673353233, 35375.64624353724, 39997.40003899886, 41706.374404384565, 43850.0, 43904.56095439005, 44214.778926105166, 11009.504572294105, 11066.0, 11102.833457497982, 11337.03635191018, 11652.94173529127, 11278.266912650652, 11375.54497820078, 11411.771764564495, 11611.941940290244, 12000.399980001139, 9894.15899648538, 10006.249531285037, 10207.489625518843, 10322.793544129225, 10377.117944974761, 10710.839337410102, 11330.150238731963, 11387.544498219979, 11409.087273018305, 11805.704857378634, 10605.363678179334, 10621.734456638645, 10624.096951759188, 10661.253712240068, 10941.671749847517, 8822.911770882465, 9057.230135438562, 9460.243180545402, 9467.573959171992, 9470.573824178065, 7969.203079691984, 8257.917420825715, 8364.330853531825, 8462.0, 9033.187013168847], "unit": "score", "name": "yui.html", "value": 6197.380846584611}], "name": "dromaeo_css", "value": 6739.285567611071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 111.0, 110.0, 101.0, 109.0, 109.0, 117.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 150.0, 162.0, 124.0, 150.0, 152.0, 123.0, 176.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 159.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 85.0, 93.0, 74.0, 75.0, 72.0, 105.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 96.0, 96.0, 96.0, 135.0, 95.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 74.0, 69.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 88.0, 85.0, 86.0, 87.0, 85.0, 91.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 124.0, 132.0, 117.0, 121.0, 124.0, 122.0, 126.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 149.0, 148.0, 151.0, 141.0, 149.0, 151.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1501.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.39861065167054], "unit": "score", "name": "Richards", "value": 213.43589200000002}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [769.2307692307693], "unit": "score", "name": "Earley", "value": 866.4018999999997}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [41489.795918367345], "unit": "score", "name": "RegExp", "value": 21.956844564682726}, {"lowerIsBetter": false, "replicates": [574.9427917620137], "unit": "score", "name": "Splay", "value": 141.73758009950245}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19038.7478965011}]} 14:25:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19038.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6739.28"}}} 14:25:51 INFO - Return code: 0 14:25:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:51 INFO - # TBPL SUCCESS # 14:25:51 INFO - Running post-action listener: _resource_record_post_action 14:25:51 INFO - Running post-run listener: _resource_record_post_run 14:25:52 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 544010240; Read time: 0; Write time: 460252 14:25:52 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 239280128; Read time: 0; Write time: 229980 14:25:52 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 304410624; Read time: 0; Write time: 230272 14:25:52 INFO - Running post-run listener: _upload_blobber_files 14:25:52 INFO - Blob upload gear active. 14:25:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:25:52 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 14:25:52 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'] 14:25:52 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 14:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:54 INFO - (blobuploader) - INFO - Done attempting. 14:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:54 INFO - (blobuploader) - INFO - Done attempting. 14:25:54 INFO - (blobuploader) - INFO - Iteration through files over. 14:25:54 INFO - Return code: 0 14:25:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:25:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:25:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1364e49ebe523ef08a56c974aa6b7d9ceedf0314b6f460bc7c5d814785d77bb7bc46a64c3ef69b5cb4d8b41421e528d50e021853a0ed4df761ae98efc0d7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/028991bdcfadba748c3370b197f9685e9af0b8f7b49c4aa325a9ee3cf9860dbba6d56e53dc53efed56ca9a511114deb209de6d8fc02a38d8067ce60ea314feb7"} 14:25:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:25:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:25:54 INFO - Contents: 14:25:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1364e49ebe523ef08a56c974aa6b7d9ceedf0314b6f460bc7c5d814785d77bb7bc46a64c3ef69b5cb4d8b41421e528d50e021853a0ed4df761ae98efc0d7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/028991bdcfadba748c3370b197f9685e9af0b8f7b49c4aa325a9ee3cf9860dbba6d56e53dc53efed56ca9a511114deb209de6d8fc02a38d8067ce60ea314feb7"} 14:25:54 INFO - Copying logs to upload dir... 14:25:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.747985 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-12 14:25:54.548469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 14:25:54.551487) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1364e49ebe523ef08a56c974aa6b7d9ceedf0314b6f460bc7c5d814785d77bb7bc46a64c3ef69b5cb4d8b41421e528d50e021853a0ed4df761ae98efc0d7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/028991bdcfadba748c3370b197f9685e9af0b8f7b49c4aa325a9ee3cf9860dbba6d56e53dc53efed56ca9a511114deb209de6d8fc02a38d8067ce60ea314feb7"} build_url:https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/VnPP_KCTTWeMQS5GhrYSEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa1364e49ebe523ef08a56c974aa6b7d9ceedf0314b6f460bc7c5d814785d77bb7bc46a64c3ef69b5cb4d8b41421e528d50e021853a0ed4df761ae98efc0d7d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/028991bdcfadba748c3370b197f9685e9af0b8f7b49c4aa325a9ee3cf9860dbba6d56e53dc53efed56ca9a511114deb209de6d8fc02a38d8067ce60ea314feb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 14:25:54.575979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:25:54.576304) ========= 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=ed14279e38b05397cf4aa391000001a4-1452634217.684216-142942270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 14:25:54.660272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 14:25:54.660593) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 14:25:54.660913) ========= ========= Total master_lag: 0.25 =========