builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1453488342.99 results: success (0) buildid: 20160122083030 builduid: 5871b987d8624c8c92284ae9f28e9151 revision: 1cf358aab01b00bd6e04c492c1a604548063ea19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:42.992495) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:42.993037) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:42.993402) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.015041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.015385) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.023423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.023761) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.070680) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.071011) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.071414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.071772) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 10:45:43-- 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% 224M=0s 2016-01-22 10:45:43 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.177618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.177994) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.228580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.228976) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1cf358aab01b00bd6e04c492c1a604548063ea19 --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 1cf358aab01b00bd6e04c492c1a604548063ea19 --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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 10:45:43,766 truncating revision to first 12 chars 2016-01-22 10:45:43,766 Setting DEBUG logging. 2016-01-22 10:45:43,767 attempt 1/10 2016-01-22 10:45:43,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1cf358aab01b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 10:45:44,083 unpacking tar archive at: fx-team-1cf358aab01b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.841612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.842004) ========= echo 1cf358aab01b00bd6e04c492c1a604548063ea19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1cf358aab01b00bd6e04c492c1a604548063ea19'] 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1cf358aab01b00bd6e04c492c1a604548063ea19 program finished with exit code 0 elapsedTime=0.003988 script_repo_revision: '1cf358aab01b00bd6e04c492c1a604548063ea19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.891114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.891471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 10:45:43.901579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-22 10:45:43.901942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:45:44 INFO - MultiFileLogger online at 20160122 10:45:44 in /builds/slave/test-pgo 10:45:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:45:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:45:44 INFO - {'append_to_log': False, 10:45:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:45:44 INFO - 'blob_upload_branch': 'Fx-Team', 10:45:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:45:44 INFO - 'branch': 'Fx-Team', 10:45:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:44 INFO - 'config_files': ('talos/linux_config.py',), 10:45:44 INFO - 'default_actions': ('clobber', 10:45:44 INFO - 'read-buildbot-config', 10:45:44 INFO - 'download-and-extract', 10:45:44 INFO - 'populate-webroot', 10:45:44 INFO - 'create-virtualenv', 10:45:44 INFO - 'install', 10:45:44 INFO - 'run-tests'), 10:45:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:44 INFO - 'download_minidump_stackwalk': True, 10:45:44 INFO - 'download_symbols': 'ondemand', 10:45:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:44 INFO - 'installer_path': 'installer.exe', 10:45:44 INFO - 'log_level': 'info', 10:45:44 INFO - 'log_name': 'talos', 10:45:44 INFO - 'log_to_console': True, 10:45:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:45:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:45:44 INFO - 'opt_config_files': (), 10:45:44 INFO - 'pip_index': False, 10:45:44 INFO - 'sps_profile': False, 10:45:44 INFO - 'sps_profile_interval': 0, 10:45:44 INFO - 'suite': 'dromaeojs-e10s', 10:45:44 INFO - 'system_bits': '32', 10:45:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:44 INFO - 'title': 'talos-linux64-ix-007', 10:45:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:44 INFO - 'use_talos_json': True, 10:45:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:45:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:44 INFO - 'work_dir': 'build'} 10:45:44 INFO - ##### 10:45:44 INFO - ##### Running clobber step. 10:45:44 INFO - ##### 10:45:44 INFO - Running pre-action listener: _resource_record_pre_action 10:45:44 INFO - Running main action method: clobber 10:45:44 INFO - rmtree: /builds/slave/test-pgo/build 10:45:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:45:44 INFO - Running post-action listener: _resource_record_post_action 10:45:44 INFO - ##### 10:45:44 INFO - ##### Running read-buildbot-config step. 10:45:44 INFO - ##### 10:45:44 INFO - Running pre-action listener: _resource_record_pre_action 10:45:44 INFO - Running main action method: read_buildbot_config 10:45:44 INFO - Using buildbot properties: 10:45:44 INFO - { 10:45:44 INFO - "project": "", 10:45:44 INFO - "product": "firefox", 10:45:44 INFO - "script_repo_revision": "production", 10:45:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:45:44 INFO - "repository": "", 10:45:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:45:44 INFO - "buildid": "20160122083030", 10:45:44 INFO - "pgo_build": "True", 10:45:44 INFO - "basedir": "/builds/slave/test-pgo", 10:45:44 INFO - "buildnumber": 233, 10:45:44 INFO - "slavename": "talos-linux64-ix-007", 10:45:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:45:44 INFO - "platform": "ubuntu64_hw", 10:45:44 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:45:44 INFO - "branch": "fx-team", 10:45:44 INFO - "repo_path": "integration/fx-team", 10:45:44 INFO - "revision": "1cf358aab01b00bd6e04c492c1a604548063ea19", 10:45:44 INFO - "stage_platform": "linux64-pgo", 10:45:44 INFO - "builduid": "5871b987d8624c8c92284ae9f28e9151", 10:45:44 INFO - "slavebuilddir": "test" 10:45:44 INFO - } 10:45:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:45:44 INFO - Running post-action listener: _resource_record_post_action 10:45:44 INFO - ##### 10:45:44 INFO - ##### Running download-and-extract step. 10:45:44 INFO - ##### 10:45:44 INFO - Running pre-action listener: _resource_record_pre_action 10:45:44 INFO - Running main action method: download_and_extract 10:45:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:44 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:45:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json 10:45:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json 10:45:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:45:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:45:45 INFO - Downloaded 1448 bytes. 10:45:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:45:45 INFO - Using the following test package requirements: 10:45:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:45:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:45:45 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:45:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'jsshell-linux-x86_64.zip'], 10:45:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:45:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:45:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:45:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:45:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:45:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:45:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:45:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:45 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:46 INFO - Downloaded 22488230 bytes. 10:45:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:45:47 INFO - Return code: 0 10:45:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:47 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:49 INFO - Downloaded 22488230 bytes. 10:45:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:45:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:45:50 INFO - Return code: 0 10:45: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')]} 10:45:50 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:45:51 INFO - Downloaded 10706572 bytes. 10:45:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:45:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:45:51 INFO - Return code: 0 10:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:51 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:45:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:45:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:45:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:45:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:45:52 INFO - Downloaded 55955407 bytes. 10:45:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:45:52 INFO - mkdir: /builds/slave/test-pgo/properties 10:45:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:45:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:45:52 INFO - Contents: 10:45:52 INFO - build_url:https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:45:52 INFO - Running post-action listener: _resource_record_post_action 10:45:52 INFO - Running post-action listener: set_extra_try_arguments 10:45:52 INFO - ##### 10:45:52 INFO - ##### Running populate-webroot step. 10:45:52 INFO - ##### 10:45:52 INFO - Running pre-action listener: _resource_record_pre_action 10:45:52 INFO - Running main action method: populate_webroot 10:45:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:52 INFO - '--tppagecycles', 10:45:52 INFO - '7'], 10:45:52 INFO - 'tests': ['tsvgm']}}, 10:45:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:45:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:45:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:45:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'tests': ['damp', 'tps']}, 10:45:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['damp', 'tps']}, 10:45:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:45:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:52 INFO - 'other': {'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'other_l64': {'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'other_nol64': {'tests': ['a11yr', 10:45:52 INFO - 'ts_paint', 10:45:52 INFO - 'tpaint', 10:45:52 INFO - 'sessionrestore', 10:45:52 INFO - 'sessionrestore_no_auto_restore']}, 10:45:52 INFO - 'svgr': {'tests': ['tsvgx', 10:45:52 INFO - 'tsvgr_opacity', 10:45:52 INFO - 'tart', 10:45:52 INFO - 'tscrollx', 10:45:52 INFO - 'cart']}, 10:45:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['tsvgx', 10:45:52 INFO - 'tsvgr_opacity', 10:45:52 INFO - 'tart', 10:45:52 INFO - 'tscrollx', 10:45:52 INFO - 'cart']}, 10:45:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'tests': ['tp5o']}, 10:45:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'talos_options': ['--e10s'], 10:45:52 INFO - 'tests': ['tp5o']}, 10:45:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'talos_options': ['--xperf_path', 10:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:52 INFO - 'tests': ['tp5n']}, 10:45:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:52 INFO - 'talos_options': ['--e10s', 10:45:52 INFO - '--xperf_path', 10:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:52 INFO - 'tests': ['tp5n']}}, 10:45:52 INFO - 'talos.zip': {'path': '', 10:45:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:52 INFO - Running post-action listener: _resource_record_post_action 10:45:52 INFO - ##### 10:45:52 INFO - ##### Running create-virtualenv step. 10:45:52 INFO - ##### 10:45:52 INFO - Running pre-action listener: _resource_record_pre_action 10:45:52 INFO - Running main action method: create_virtualenv 10:45:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:45:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:45:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:45:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:53 INFO - Using real prefix '/usr' 10:45:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:45:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:45:55 INFO - Installing pip.................done. 10:45:55 INFO - Return code: 0 10:45:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:45:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:45:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:45:55 INFO - Using env: {'DISPLAY': ':0', 10:45:55 INFO - 'HOME': '/home/cltbld', 10:45:55 INFO - 'LANG': 'en_US.UTF-8', 10:45:55 INFO - 'LANGUAGE': 'en_US:en', 10:45:55 INFO - 'LOGNAME': 'cltbld', 10:45:55 INFO - 'MAIL': '/var/mail/cltbld', 10:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:55 INFO - 'MOZ_NO_REMOTE': '1', 10:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:55 INFO - 'NO_EM_RESTART': '1', 10:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:45:55 INFO - 'SHELL': '/bin/bash', 10:45:55 INFO - 'SHLVL': '1', 10:45:55 INFO - 'TERM': 'linux', 10:45:55 INFO - 'TMOUT': '86400', 10:45:55 INFO - 'USER': 'cltbld', 10:45:55 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:55 INFO - '_': '/tools/buildbot/bin/python'} 10:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:45:55 INFO - Cleaning up... 10:45:55 INFO - Return code: 0 10:45:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:45:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:45:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:45:55 INFO - Using env: {'DISPLAY': ':0', 10:45:55 INFO - 'HOME': '/home/cltbld', 10:45:55 INFO - 'LANG': 'en_US.UTF-8', 10:45:55 INFO - 'LANGUAGE': 'en_US:en', 10:45:55 INFO - 'LOGNAME': 'cltbld', 10:45:55 INFO - 'MAIL': '/var/mail/cltbld', 10:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:55 INFO - 'MOZ_NO_REMOTE': '1', 10:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:55 INFO - 'NO_EM_RESTART': '1', 10:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:45:55 INFO - 'SHELL': '/bin/bash', 10:45:55 INFO - 'SHLVL': '1', 10:45:55 INFO - 'TERM': 'linux', 10:45:55 INFO - 'TMOUT': '86400', 10:45:55 INFO - 'USER': 'cltbld', 10:45:55 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:55 INFO - '_': '/tools/buildbot/bin/python'} 10:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:56 INFO - Downloading/unpacking psutil>=0.7.1 10:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:45:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:57 INFO - Installing collected packages: psutil 10:45:57 INFO - Running setup.py install for psutil 10:45:57 INFO - building 'psutil._psutil_linux' extension 10:45:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:45:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:45:58 INFO - building 'psutil._psutil_posix' extension 10:45:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:45:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:45:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:58 INFO - Successfully installed psutil 10:45:58 INFO - Cleaning up... 10:45:58 INFO - Return code: 0 10:45:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:45:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:45:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:45:58 INFO - Using env: {'DISPLAY': ':0', 10:45:58 INFO - 'HOME': '/home/cltbld', 10:45:58 INFO - 'LANG': 'en_US.UTF-8', 10:45:58 INFO - 'LANGUAGE': 'en_US:en', 10:45:58 INFO - 'LOGNAME': 'cltbld', 10:45:58 INFO - 'MAIL': '/var/mail/cltbld', 10:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:58 INFO - 'MOZ_NO_REMOTE': '1', 10:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:58 INFO - 'NO_EM_RESTART': '1', 10:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:45:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:45:58 INFO - 'SHELL': '/bin/bash', 10:45:58 INFO - 'SHLVL': '1', 10:45:58 INFO - 'TERM': 'linux', 10:45:58 INFO - 'TMOUT': '86400', 10:45:58 INFO - 'USER': 'cltbld', 10:45:58 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:58 INFO - '_': '/tools/buildbot/bin/python'} 10:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:46:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:46:00 INFO - Installing collected packages: mozsystemmonitor 10:46:00 INFO - Running setup.py install for mozsystemmonitor 10:46:00 INFO - Successfully installed mozsystemmonitor 10:46:00 INFO - Cleaning up... 10:46:00 INFO - Return code: 0 10:46:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:46:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:46:00 INFO - Using env: {'DISPLAY': ':0', 10:46:00 INFO - 'HOME': '/home/cltbld', 10:46:00 INFO - 'LANG': 'en_US.UTF-8', 10:46:00 INFO - 'LANGUAGE': 'en_US:en', 10:46:00 INFO - 'LOGNAME': 'cltbld', 10:46:00 INFO - 'MAIL': '/var/mail/cltbld', 10:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:00 INFO - 'MOZ_NO_REMOTE': '1', 10:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:00 INFO - 'NO_EM_RESTART': '1', 10:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:00 INFO - 'SHELL': '/bin/bash', 10:46:00 INFO - 'SHLVL': '1', 10:46:00 INFO - 'TERM': 'linux', 10:46:00 INFO - 'TMOUT': '86400', 10:46:00 INFO - 'USER': 'cltbld', 10:46:00 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:00 INFO - '_': '/tools/buildbot/bin/python'} 10:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:46:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:46:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:03 INFO - Downloading docopt-0.6.1.tar.gz 10:46:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:46:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:46:03 INFO - Running setup.py install for blobuploader 10:46:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:46:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:46:03 INFO - Running setup.py install for requests 10:46:03 INFO - Running setup.py install for docopt 10:46:03 INFO - Successfully installed blobuploader requests docopt 10:46:03 INFO - Cleaning up... 10:46:03 INFO - Return code: 0 10:46:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:46:03 INFO - Using env: {'DISPLAY': ':0', 10:46:03 INFO - 'HOME': '/home/cltbld', 10:46:03 INFO - 'LANG': 'en_US.UTF-8', 10:46:03 INFO - 'LANGUAGE': 'en_US:en', 10:46:03 INFO - 'LOGNAME': 'cltbld', 10:46:03 INFO - 'MAIL': '/var/mail/cltbld', 10:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:03 INFO - 'MOZ_NO_REMOTE': '1', 10:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:03 INFO - 'NO_EM_RESTART': '1', 10:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:03 INFO - 'SHELL': '/bin/bash', 10:46:03 INFO - 'SHLVL': '1', 10:46:03 INFO - 'TERM': 'linux', 10:46:03 INFO - 'TMOUT': '86400', 10:46:03 INFO - 'USER': 'cltbld', 10:46:03 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:03 INFO - '_': '/tools/buildbot/bin/python'} 10:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:46:04 INFO - Running setup.py (path:/tmp/pip-P1NS20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:46:04 INFO - Running setup.py (path:/tmp/pip-q3z2OV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:46:04 INFO - Running setup.py (path:/tmp/pip-6_71zH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:46:04 INFO - Running setup.py (path:/tmp/pip-dFbbAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:46:04 INFO - Running setup.py (path:/tmp/pip-XDUWlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:46:04 INFO - Running setup.py (path:/tmp/pip-bUDS0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:46:04 INFO - Running setup.py (path:/tmp/pip-y8R4iY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:46:04 INFO - Running setup.py (path:/tmp/pip-jz0OyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:46:04 INFO - Running setup.py (path:/tmp/pip-8rabbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:46:04 INFO - Running setup.py (path:/tmp/pip-Pnequ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:46:04 INFO - Running setup.py (path:/tmp/pip-cOTB4k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:46:04 INFO - Running setup.py (path:/tmp/pip-0_SYzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:46:05 INFO - Running setup.py (path:/tmp/pip-XwsZ6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:46:05 INFO - Running setup.py (path:/tmp/pip-kaqGnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:46:05 INFO - Running setup.py (path:/tmp/pip-X292Iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:46:05 INFO - Running setup.py (path:/tmp/pip-rQihmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:46:05 INFO - Running setup.py (path:/tmp/pip-u215W1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:46:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:46:05 INFO - Running setup.py install for manifestparser 10:46:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:46:05 INFO - Running setup.py install for mozcrash 10:46:05 INFO - Running setup.py install for mozdebug 10:46:05 INFO - Running setup.py install for mozdevice 10:46:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:46:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:46:05 INFO - Running setup.py install for mozfile 10:46:05 INFO - Running setup.py install for mozhttpd 10:46:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:46:05 INFO - Running setup.py install for mozinfo 10:46:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for mozInstall 10:46:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for mozleak 10:46:06 INFO - Running setup.py install for mozlog 10:46:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for moznetwork 10:46:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for mozprocess 10:46:06 INFO - Running setup.py install for mozprofile 10:46:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for mozrunner 10:46:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:46:06 INFO - Running setup.py install for mozscreenshot 10:46:06 INFO - Running setup.py install for moztest 10:46:07 INFO - Running setup.py install for mozversion 10:46:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:46:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:46:07 INFO - Cleaning up... 10:46:07 INFO - Return code: 0 10:46:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:46:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:46:07 INFO - Using env: {'DISPLAY': ':0', 10:46:07 INFO - 'HOME': '/home/cltbld', 10:46:07 INFO - 'LANG': 'en_US.UTF-8', 10:46:07 INFO - 'LANGUAGE': 'en_US:en', 10:46:07 INFO - 'LOGNAME': 'cltbld', 10:46:07 INFO - 'MAIL': '/var/mail/cltbld', 10:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:07 INFO - 'MOZ_NO_REMOTE': '1', 10:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:07 INFO - 'NO_EM_RESTART': '1', 10:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:07 INFO - 'SHELL': '/bin/bash', 10:46:07 INFO - 'SHLVL': '1', 10:46:07 INFO - 'TERM': 'linux', 10:46:07 INFO - 'TMOUT': '86400', 10:46:07 INFO - 'USER': 'cltbld', 10:46:07 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:07 INFO - '_': '/tools/buildbot/bin/python'} 10:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:46:07 INFO - Running setup.py (path:/tmp/pip-tBhOh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:46:07 INFO - Running setup.py (path:/tmp/pip-KRQ2At-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:46:07 INFO - Running setup.py (path:/tmp/pip-NzvCDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:46:07 INFO - Running setup.py (path:/tmp/pip-nDxis7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:46:07 INFO - Running setup.py (path:/tmp/pip-YChiC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:46:07 INFO - Running setup.py (path:/tmp/pip-vOg5Aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:46:07 INFO - Running setup.py (path:/tmp/pip-WJw6T0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:46:07 INFO - Running setup.py (path:/tmp/pip-lf_UVY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:46:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:46:07 INFO - Running setup.py (path:/tmp/pip-65LndB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:46:08 INFO - Running setup.py (path:/tmp/pip-p28qvx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:46:08 INFO - Running setup.py (path:/tmp/pip-yqBRSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:46:08 INFO - Running setup.py (path:/tmp/pip-24bPRw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:46:08 INFO - Running setup.py (path:/tmp/pip-9DzyGr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:46:08 INFO - Running setup.py (path:/tmp/pip-V_qmm4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:46:08 INFO - Running setup.py (path:/tmp/pip-xz5huq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:46:08 INFO - Running setup.py (path:/tmp/pip-rYye_b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:46:08 INFO - Running setup.py (path:/tmp/pip-9s872b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:46:08 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:46:08 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:46:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:10 INFO - Downloading blessings-1.6.tar.gz 10:46:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:46:10 INFO - Installing collected packages: blessings 10:46:10 INFO - Running setup.py install for blessings 10:46:10 INFO - Successfully installed blessings 10:46:10 INFO - Cleaning up... 10:46:10 INFO - Return code: 0 10:46:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:46:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:46:10 INFO - Reading from file tmpfile_stdout 10:46:10 INFO - Current package versions: 10:46:10 INFO - argparse == 1.2.1 10:46:10 INFO - blessings == 1.6 10:46:10 INFO - blobuploader == 1.2.4 10:46:10 INFO - docopt == 0.6.1 10:46:10 INFO - manifestparser == 1.1 10:46:10 INFO - mozInstall == 1.12 10:46:10 INFO - mozcrash == 0.16 10:46:10 INFO - mozdebug == 0.1 10:46:10 INFO - mozdevice == 0.48 10:46:10 INFO - mozfile == 1.2 10:46:10 INFO - mozhttpd == 0.7 10:46:10 INFO - mozinfo == 0.9 10:46:10 INFO - mozleak == 0.1 10:46:10 INFO - mozlog == 3.1 10:46:10 INFO - moznetwork == 0.27 10:46:10 INFO - mozprocess == 0.22 10:46:10 INFO - mozprofile == 0.28 10:46:10 INFO - mozrunner == 6.11 10:46:10 INFO - mozscreenshot == 0.1 10:46:10 INFO - mozsystemmonitor == 0.0 10:46:10 INFO - moztest == 0.7 10:46:10 INFO - mozversion == 1.4 10:46:10 INFO - psutil == 3.1.1 10:46:10 INFO - requests == 1.2.3 10:46:10 INFO - wsgiref == 0.1.2 10:46:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:46:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:46:10 INFO - Using env: {'DISPLAY': ':0', 10:46:10 INFO - 'HOME': '/home/cltbld', 10:46:10 INFO - 'LANG': 'en_US.UTF-8', 10:46:10 INFO - 'LANGUAGE': 'en_US:en', 10:46:10 INFO - 'LOGNAME': 'cltbld', 10:46:10 INFO - 'MAIL': '/var/mail/cltbld', 10:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:10 INFO - 'MOZ_NO_REMOTE': '1', 10:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:10 INFO - 'NO_EM_RESTART': '1', 10:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:10 INFO - 'SHELL': '/bin/bash', 10:46:10 INFO - 'SHLVL': '1', 10:46:10 INFO - 'TERM': 'linux', 10:46:10 INFO - 'TMOUT': '86400', 10:46:10 INFO - 'USER': 'cltbld', 10:46:10 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:10 INFO - '_': '/tools/buildbot/bin/python'} 10:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:46:11 INFO - Cleaning up... 10:46:11 INFO - Return code: 0 10:46:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:46: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')]} 10:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46: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')]} 10:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:46:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:46:11 INFO - Using env: {'DISPLAY': ':0', 10:46:11 INFO - 'HOME': '/home/cltbld', 10:46:11 INFO - 'LANG': 'en_US.UTF-8', 10:46:11 INFO - 'LANGUAGE': 'en_US:en', 10:46:11 INFO - 'LOGNAME': 'cltbld', 10:46:11 INFO - 'MAIL': '/var/mail/cltbld', 10:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:11 INFO - 'MOZ_NO_REMOTE': '1', 10:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:11 INFO - 'NO_EM_RESTART': '1', 10:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:11 INFO - 'SHELL': '/bin/bash', 10:46:11 INFO - 'SHLVL': '1', 10:46:11 INFO - 'TERM': 'linux', 10:46:11 INFO - 'TMOUT': '86400', 10:46:11 INFO - 'USER': 'cltbld', 10:46:11 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:11 INFO - '_': '/tools/buildbot/bin/python'} 10:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:11 INFO - Downloading/unpacking jsonschema 10:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:46:13 INFO - Downloading/unpacking functools32 (from jsonschema) 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:46:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:46:13 INFO - warning: no files found matching '*.txt' 10:46:13 INFO - no previously-included directories found matching 'build' 10:46:13 INFO - no previously-included directories found matching 'dist' 10:46:13 INFO - no previously-included directories found matching '.git*' 10:46:13 INFO - Installing collected packages: jsonschema, functools32 10:46:13 INFO - Running setup.py install for functools32 10:46:13 INFO - warning: no files found matching '*.txt' 10:46:13 INFO - no previously-included directories found matching 'build' 10:46:13 INFO - no previously-included directories found matching 'dist' 10:46:13 INFO - no previously-included directories found matching '.git*' 10:46:13 INFO - Successfully installed jsonschema functools32 10:46:13 INFO - Cleaning up... 10:46:13 INFO - Return code: 0 10:46:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:46:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8da2c99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f06630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:46:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:46:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:46:13 INFO - Using env: {'DISPLAY': ':0', 10:46:13 INFO - 'HOME': '/home/cltbld', 10:46:13 INFO - 'LANG': 'en_US.UTF-8', 10:46:13 INFO - 'LANGUAGE': 'en_US:en', 10:46:13 INFO - 'LOGNAME': 'cltbld', 10:46:13 INFO - 'MAIL': '/var/mail/cltbld', 10:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:13 INFO - 'MOZ_NO_REMOTE': '1', 10:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:13 INFO - 'NO_EM_RESTART': '1', 10:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:13 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:13 INFO - 'SHELL': '/bin/bash', 10:46:13 INFO - 'SHLVL': '1', 10:46:13 INFO - 'TERM': 'linux', 10:46:13 INFO - 'TMOUT': '86400', 10:46:13 INFO - 'USER': 'cltbld', 10:46:13 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:13 INFO - '_': '/tools/buildbot/bin/python'} 10:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:13 INFO - Downloading/unpacking flake8 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:46:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:46:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46: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 10:46:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:16 INFO - no previously-included directories found matching 'docs/_build' 10:46:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:46:16 INFO - Running setup.py install for pep8 10:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:46:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:46:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:46:16 INFO - no previously-included directories found matching 'docs/_build' 10:46:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:46:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:46:16 INFO - Cleaning up... 10:46:16 INFO - Return code: 0 10:46:16 INFO - Running post-action listener: _resource_record_post_action 10:46:16 INFO - Running post-action listener: _start_resource_monitoring 10:46:16 INFO - Starting resource monitoring. 10:46:16 INFO - ##### 10:46:16 INFO - ##### Running install step. 10:46:16 INFO - ##### 10:46:16 INFO - Running pre-action listener: _resource_record_pre_action 10:46:16 INFO - Running main action method: install 10:46:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:46:16 INFO - Reading from file tmpfile_stdout 10:46:16 INFO - Detecting whether we're running mozinstall >=1.0... 10:46:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:46:16 INFO - Reading from file tmpfile_stdout 10:46:16 INFO - Output received: 10:46:16 INFO - Usage: mozinstall [options] installer 10:46:16 INFO - Options: 10:46:16 INFO - -h, --help show this help message and exit 10:46:16 INFO - -d DEST, --destination=DEST 10:46:16 INFO - Directory to install application into. [default: 10:46:16 INFO - "/builds/slave/test-pgo"] 10:46:16 INFO - --app=APP Application being installed. [default: firefox] 10:46:16 INFO - mkdir: /builds/slave/test-pgo/build/application 10:46:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:46:32 INFO - Reading from file tmpfile_stdout 10:46:32 INFO - Output received: 10:46:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:46:32 INFO - Running post-action listener: _resource_record_post_action 10:46:32 INFO - ##### 10:46:32 INFO - ##### Running run-tests step. 10:46:32 INFO - ##### 10:46:32 INFO - Running pre-action listener: _resource_record_pre_action 10:46:32 INFO - Running main action method: run_tests 10:46:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:46:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:46:32 INFO - Python 2.7.3 10:46:32 INFO - Return code: 0 10:46:32 INFO - grabbing minidump binary from tooltool 10:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:32 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 0x1f97840>, '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 0x1f046b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f04b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:46:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:46:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:46:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:46:32 INFO - Return code: 0 10:46:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:46:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:46:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:46:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:46:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:46:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:46:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:46:33 INFO - Return code: 0 10:46:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:46:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:46:33 INFO - Using env: {'DISPLAY': ':0', 10:46:33 INFO - 'HOME': '/home/cltbld', 10:46:33 INFO - 'LANG': 'en_US.UTF-8', 10:46:33 INFO - 'LANGUAGE': 'en_US:en', 10:46:33 INFO - 'LOGNAME': 'cltbld', 10:46:33 INFO - 'MAIL': '/var/mail/cltbld', 10:46:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:46:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:33 INFO - 'MOZ_NO_REMOTE': '1', 10:46:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:33 INFO - 'NO_EM_RESTART': '1', 10:46:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:46:33 INFO - 'PWD': '/builds/slave/test-pgo', 10:46:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:46:33 INFO - 'SHELL': '/bin/bash', 10:46:33 INFO - 'SHLVL': '1', 10:46:33 INFO - 'TERM': 'linux', 10:46:33 INFO - 'TMOUT': '86400', 10:46:33 INFO - 'USER': 'cltbld', 10:46:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137', 10:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:33 INFO - '_': '/tools/buildbot/bin/python'} 10:46:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:46:34 INFO - mozversion application_buildid: 20160122083030 10:46:34 INFO - mozversion application_changeset: 1cf358aab01b00bd6e04c492c1a604548063ea19 10:46:34 INFO - mozversion application_display_name: Nightly 10:46:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:46:34 INFO - mozversion application_name: Firefox 10:46:34 INFO - mozversion application_remotingname: firefox 10:46:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:46:34 INFO - mozversion application_vendor: Mozilla 10:46:34 INFO - mozversion application_version: 46.0a1 10:46:34 INFO - mozversion platform_buildid: 20160122083030 10:46:34 INFO - mozversion platform_changeset: 1cf358aab01b00bd6e04c492c1a604548063ea19 10:46:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:46:34 INFO - mozversion platform_version: 46.0a1 10:46:34 INFO - using testdate: 1453488394 10:46:34 INFO - actual date: 1453488394 10:46:34 INFO - starting webserver on 'localhost:59976' 10:46:34 INFO - SUITE-START | Running 3 tests 10:46:34 INFO - TEST-START | dromaeo_css 10:46:34 INFO - operating with platform_type : linux_ 10:46:34 INFO - Initialising browser for dromaeo_css test... 10:46:34 INFO - TEST-INFO | started process 31781 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLAmEO/profile http://localhost:59976/getInfo.html) 10:46:37 INFO - PROCESS | 31781 | 10:46:37 INFO - PROCESS | 31781 | (process:31866): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:46:38 INFO - PROCESS | 31781 | __metrics Screen width/height:1600/1200 10:46:38 INFO - PROCESS | 31781 | colorDepth:24 10:46:38 INFO - PROCESS | 31781 | Browser inner width/height: 1024/697 10:46:38 INFO - PROCESS | 31781 | __metrics 10:46:38 INFO - PROCESS | 31781 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:46:39 INFO - TEST-INFO | 31781: exit 0 10:46:39 INFO - Browser initialized. 10:46:39 INFO - Running cycle 1/1 for dromaeo_css test... 10:46:39 INFO - TEST-INFO | started process 31915 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLAmEO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:41 INFO - PROCESS | 31915 | 10:46:41 INFO - PROCESS | 31915 | (process:31972): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:46:51 INFO - PROCESS | 31915 | RSS: Main: 150155264 10:46:51 INFO - PROCESS | 31915 | 10:47:41 INFO - PROCESS | 31915 | 1453488461231 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] 10:49:50 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59976/tests/dromaeo/cssquery-ext.html) 10:49:51 INFO - PROCESS | 31915 | RSS: Main: 160681984 10:49:51 INFO - PROCESS | 31915 | 10:52:53 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-ext.html (next: http://localhost:59976/tests/dromaeo/cssquery-jquery.html) 10:52:53 INFO - PROCESS | 31915 | RSS: Main: 154845184 10:52:53 INFO - PROCESS | 31915 | 10:55:55 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59976/tests/dromaeo/cssquery-mootools.html) 10:55:56 INFO - PROCESS | 31915 | RSS: Main: 157278208 10:55:56 INFO - PROCESS | 31915 | 10:58:57 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59976/tests/dromaeo/cssquery-prototype.html) 10:58:58 INFO - PROCESS | 31915 | RSS: Main: 154476544 10:58:58 INFO - PROCESS | 31915 | 11:02:00 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59976/tests/dromaeo/cssquery-yui.html) 11:02:01 INFO - PROCESS | 31915 | RSS: Main: 154193920 11:02:01 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | Cycle 1(1): loaded http://localhost:59976/tests/dromaeo/cssquery-yui.html (next: http://localhost:59976/tests/dromaeo/cssquery-dojo.html) 11:05:04 INFO - PROCESS | 31915 | RSS: Main: 158523392 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | __start_tp_report 11:05:04 INFO - PROCESS | 31915 | _x_x_mozilla_page_load 11:05:04 INFO - PROCESS | 31915 | _x_x_mozilla_page_load_details 11:05:04 INFO - PROCESS | 31915 | |i|pagename|runs| 11:05:04 INFO - PROCESS | 31915 | |0;dojo.html;3228.6609905959876;3234.1591186291557;3245.204924793426;3293.4071867063935;3293.9176520587;5136.794528218876;5323.281357016802;5325.760340784665;5327.946720532794;5332.920006199901;5150.330457040589;5295.735213239342;5317.654352467087;5327.334083239595;5346.91979620305;4520.864374068783;4761.14299426104;4933.506649335056;4960.875978100558;4974.552290293873;4710.670253082286;4872.975635121819;4898.534639209287;4929.260610908356;4936.210206366982;4785.928211076836;4801.735904525267;4839.080574690833;4869.5130486951375;4907.730074845882;4870.7564621769125;4881.072596206709;4893.8776530586665;4914.992426552584;4930.137225985438;4725.3384526166365;4776.09254241693;4877.853664390039;4887.780049897728;4916.8770780730765;5161.483851614846;5176.094183517869;5188.481151884819;5197.506236907488;5206.401263854629;5660.688662123582;5661.547076233933;5679.233303504016;5694.658320500783;5701.230333904911;5615.634983726045;5726.828195154152;5734.225879506255;5751.367349591584;5773.740181691834;5378.435264297232;5437.34751829783;5447.836564903059;5467.0705979983495;5504.284443022421;5755.5683323750045;5780.277465316835;5794.797182098607;5795.159701843293;5817.912731309034;5502.477264659851;5585.8603534911135;5614.07367784311;5615.073512870413;5615.466530679579;5749.540036797046;5795.072788353843;5799.826005219766;5804.448577385142;5859.9121013183985;5602.38373778884;5650.152477128464;5701.657900525982;5709.714514274269;5722.456366645162;5517.503424691797;5613.635113717677;5676;5717.313922329347;5731.856703582361;4413.360062790942;4449.243628583149;4452.9109417812115;4456.086502267028;4457.398251236042;3968.1865217630316;3978.3236849735613;3979.781112038808;4011.9799401003393;4028.7582745035393;5180.222966555047;5230.947690523122;5302.549283310885;5311.628186027018;5333.679979201261;5674.432556744293;5688.089905615082;5719.142128680731;5721.199032135504;5744.195812586241;5318.149096144675;5322.2548843161985;5324.121519949243;5326.7869285228935;5390.595705322038;4784.617230621611;4848.321235027099;4859.586935110555;4883.267509873476;4957.801687932514;5800.1299805029585;5817.912731309034;5824.475797178189;5842.065269556851;5856.648601083949;5567.5545956322585;5588.944110558842;5601.439856014366;5609.214709940693;5637.830865074055;5756.65460072397;5889.793857214977;5908.261467316585;5924.8815023700145;5930.9110363343725;5663.631863928831;5665.12190610456;5667.574931880043;5673.234113394639;5673.602847800615;5563.471470210324;5637.774489020558;5685.800996965087;5734.627249228787;5742.109972954198;5585.022621041383;5629.549636029026;5634.7464364104535;5637.43625637433;5679.119736440858;5573.191887176417;5591.077472217201;5592.161175823659;5614.606977511535;5616.354119276336;5300;5374.4088150304215;5389.407165211902;5532.6680399176175;5551.750171242223;5456.099743542271;5641.464060914206;5723.828285151452;5725.513331366714;5767.971160144172;5421.945780542144;5427.457254274541;5434.918476222781;5440.265564148789;5494.725263736717 11:05:04 INFO - PROCESS | 31915 | |1;ext.html;501.88707540803324;520.9687418754875;531.3835950297654;541.3098299667923;552.5082676417986;33908.491372629396;34275;34362;34410;34550;35529;35963;35974.640253597456;36140.63859361406;36165.2766944661;8053.395995300347;8238.958805205966;8259.628316725762;8281.37889658275;8304.418690691655;8027.3578113751055;8328.125546817588;8336.583170841433;8346.41575089744;8357.832843343129;8306.667733290662;8331.541765202912;8407.957960210191;8430.072692003874;8454.070052294242;8329.08380078191;8337.708180213695;8384.8742268866;8406.075331713506;8418.705345312885;8153.7553873383895;8281.585920703941;8283.17168283173;8285.42002059856;8292.668293268262;34766.13084672878;34864;34907.82546087279;35138.824305878305;35190.82404587986;2773.9029133980416;2777.5555911054335;2785.1087651951384;2788.5817127430846;3079.230192451887;28472.572911406347;28698.569521457193;28841.423171536662;28966.565501517493;29018.854905725337;3762.3039737648623;3902.6682731967817;3945.3884647879627;3983.701222408302;4107.466029416187;249461;251042;252279;252294;252792;49952.25071623929;50513.494865051616;55127;55559.61100972508;55595.722021389636;60023;60315;60558;60947.69526152341;61087;14542.200178990046;14783.482578109715;14803.555893323217;14888.404463821325;14910.179940103399;11052.668419947415;11076.224664273584;11167.497462614201;11177.161712871568;11206.831897521544;17950.820491795177;18373;18389.724154137697;18476.815231847508;19038.428847134608;7481.513701609378;7694.422918281151;7740.458167928304;7757.224277572311;7777.688892444239;889.7197382824389;1024.6721049264313;1053.7312985188728;1106.1095817866694;1114.3536748685742;27872;28387.290317742223;28435.85782071118;28592;28782.85608571944;975.5268694683073;987.5852142100335;994.547480896205;1012.119456073221;1034.8292531732332;13008.414621342063;13169.604911852659;13189.670258243621;13338.066335356432;13611.387487563083;315440;316257;316381;319560;321515;47337.526624734004;47560.5243947563;47782;47905.281420778716;47964.5203547967;1314.8159257703928;1326.2639235224542;1338.7657159997157;1347.690031292808;1349.2579081505132;23963.640545391485;24440;24841.627375589018;24997.87501062483;25085;37999.62000379961;38166.80916595399;38357.61642383652;38412.23175536418;38631.227375452894;297348.5132574323;297771;298112;299191;299418;29374.853125734233;30687.386252274384;31939.201519961258;32062.519062213618;32099;36426.27147457089;36876;37067.25865482621;37104.918458968954;37169;30479.695203047686;31257.8437107813;31397.686023139475;32066.19834504156;32144.67855321417;33734.32531349408;34057;34169.829150854086;34455.13862153366;35528.289434211685;30843.537346939363;31436.528452073693;31821.681783182798;31836;31935.84032079825;27595;28772.856135719187;31022;32397.51403728993;32402.83798580992;22397.067370020777;22401.66397504006;22453.438664032878;22490.21284255043;22609.321720348416 11:05:04 INFO - PROCESS | 31915 | |2;jquery.html;361.45600870689606;361.6510067784589;364.44786148984286;366.86426022371717;368.08163631738813;15495.690086198283;15972.2013899305;16205.675886482264;16767.49697509075;17128.229229684664;10754.946225268863;10996.02147017095;15978.84021159788;16466.423675171372;16534.917325413386;4868.707877527342;6492.123563318963;6677.833054173636;6759.290274521179;6763.66181690916;6539.280679125316;6716.261211266757;6727.966360168192;6886.311368863124;6890.379865812076;6178.165947597085;6432.871342573146;6452.548321617489;6818.829529261783;6898.551594146389;6224.906626400608;6280.466160376373;6375.776847810304;6731.259561448237;6739.865202695968;6255.655938923357;6405.19935008124;6442.452391546724;6480.092787009822;6613.57808071267;20879.582408351747;21505.5698886023;21678;21832.126714931383;22564.548709025727;2238.675392068141;2253.4929640830846;2255.12050300383;2265.4223173090754;2308.4805918668335;10296.433696146709;13537.255450950193;13731.794023089662;13802.309884505734;14061.64845878851;1758.3054693396166;1812.673718730628;1832.908354582279;1891.4798430431604;1975.4370004548778;60658;61220.693896530676;61441.6927915362;61676.38323616796;61700.69149654268;14770.187639679705;14973.775393369107;15003.474878379204;15029.624259393384;15218.923905380403;23231.88384058069;23451.296461106194;23569.764302356758;23620.40948976255;23697.526049478915;8401.747947561584;8460.407771456063;8621.69824056155;8632;8641.956790216134;7105.218425973138;7138.607971445622;7281.781546553612;7302.306280903305;7332.743353982585;7365.631718414058;7433.962830185815;7466.440016998638;7540.245975402416;7541.773746787605;1797.4517772079641;1817.918193681261;1873.063468265867;2936.853157342124;3070.1096681962426;909.88171537701;933.8272419602396;977.7360112769512;985.3447457440722;990.5790039233297;15609.531714048597;16365.509034728977;16383.262753176135;16550.006999580062;16562.50312490603;845.9703910363107;873.5763154869883;889.7731078574922;928.5450129436528;944.9669261575812;8719.651213951498;8753.781155471164;8983.865242021375;9011.234045106108;9035.728928132166;373268;381540;510497;510681;518308;62664.68667656724;64048;69285.65357173182;71386;73977;1142.5886680794906;1159.4782347943628;1165.7959857025157;1175.435790820411;1186;14852.777208341668;15021.098734075991;15112.395504179709;15181.6204594886;15363.38546458174;31595.526067109473;32018.67981320157;32496.512552312208;32521.34957300888;33533;42429.7271081868;42651;42728.5727142737;43302.350464743686;43377.3493397593;7161.140663120251;7255.709771609077;7298.416126709957;7466.141393739789;7516.173220945801;10181.389116653025;10360.792784144123;10896.400697961371;10970.835437468604;11111.777764444827;9040;9041.954790226007;9233.169014788702;9273.907260927304;9336.253099752139;9535.284853636143;9653.372530785477;9681.080297371738;9748.951255243679;9864.950675246579;8880.1563851434;9356.988247526815;9428.15146636806;9547.188488978514;9598.472084035166;7207.171175314906;7276.927230727837;7327.4612331411;7335.816604584715;7399.482036257626;3210.566573512546;7921.93053937711;8609.655613775629;8717.433366831136;9339 11:05:04 INFO - PROCESS | 31915 | |3;mootools.html;1475.867171954524;1503.5940296120045;1674.0876222458758;1757.7539144519762;1795.3267524678245;7379.52033117847;7595;7610.391168706504;7768.378529717623;7809.726659566923;7746.53520788753;7766;7825.804354891131;7851.2933835954755;7851.960740196305;2284.417473544248;2296.6555016747457;2328.39461739948;2331.1025255276672;2335.369450248432;2380.595298799208;2389.307100940734;2390.916317928873;2418.6251131074623;2422.2854257993845;2282.5549017941507;2312.8612283262974;2319.605667036608;2355.281639100074;2358.749862572839;2338.356951838241;2347.4131467133216;2361.7047869016374;2372.5017746273215;2379.3218932604213;2363.0902102690416;2374.169040835711;2387.7850993410675;2394.8084153267873;2395.8921848516857;7732.149463559061;7812.414068944795;7813.374930005586;7814.921850781477;7830.256125668109;4723.315119307681;4804.975975120137;4832.637552183601;4835.395575553056;4842.878928026792;2974.107767669712;3016.4871971764633;3030.31817840984;3048.2684155802667;3092.0723782865275;936.9365769851199;951.728757304165;969.4377261188494;989.9703008909744;991.8212130122938;10570.630027948984;10645.148388129008;10706.571737130505;10720.410377429238;10728.141748660088;4205.285101532747;4215;4278.379634952915;4292.678049146327;4388.780560972003;8704.129587041245;8738;8740.388172827841;8746.737597872074;8798.164174403422;4822.324874517571;4843;4876.390451193601;4882.365292512021;4888.046830868017;4433.844815431509;4445.244308467568;4469.150861336336;4482.21561226784;4492.752898590609;3556.02209392414;3563.768355056913;3586.1393265616066;3601.1897323102094;3602.85588576454;1014.3558840136419;1090.6019302954523;1101.8732845722684;1114.0363585498646;1117.0728295514702;972.5234635028785;1016.7813920007234;1059.9364038157735;1064.5794911010107;1216.2337727231964;6805.047293378931;6900.5859648420255;6906;6915.446764258847;6931.4108300795;619.4332186049804;630.5554584018348;633.7084940927133;634.403660559073;745.2473002267749;5369.36234448497;5385.380681221632;5409.972950135224;5411.648242864201;5445.564354851603;8783.648654053894;8960.731178064669;9175.58709858058;9261.259099272042;9280.814383712423;9117;9161.221296189766;9162.496062716615;9172.72481825533;9219;6872.828179295458;7016.789496315118;7088.645567721594;7108.92891071093;7223.494355395072;6964.408025317702;6999.615021173884;7011.894821577578;7018.368346848808;7042.471814613822;8167.754967350751;8199.262066414052;8305.543195124326;8325.791855203668;8382.203690649378;8400.159984001551;8609;8624.353173511887;8644.740657780276;8660.35047371437;6278.434940855345;6606.47148228131;6830.214525329452;6845.110135682329;6861.176658800976;7208;7216.675249613675;7262.419006479575;7283.526570772883;7290.4896657233485;5970.253718285215;6631.801045968628;6738.225104113089;6813.4549236061985;6993;6724.361185687352;6745.696443659949;6799.830004249736;6847.144106986627;6884.621345826027;6473.158489396348;6595.241547221939;6610.471162306908;6623.205215374186;6631.767888123893;6403.679816009274;6411.294757576569;6454.257760357431;6461.644609546332;6476.870462590816;6229.4393504584805;6302.117703521602;6309.558330916791;6337.683115844097;6383.042543618494 11:05:04 INFO - PROCESS | 31915 | |4;prototype.html;350.7281856561165;353.8832185378825;354.96095429502765;356.04224635729884;357.57627211754067;6116;6116.113163591277;6175.980963141082;6234.002559590466;6248.593841400311;6118.174046503721;6206.441420272175;6244.812655620327;6247.062940558919;6264.812055638338;4760.690555113923;4793.496682848303;4806.447258565275;4807.399075115611;4819.638527110455;4806.3030860525205;4820.662553621248;4840.757962101899;4853.296272040552;4855.757212139397;4710.693804902688;4802.23164293713;4806.231003039515;4816.686915350509;4817.012512434942;4793.233082706767;4795.256735206014;4800.759962001904;4812.687175333627;4822.6624136310475;4199.160167966419;4229.36559516072;4246.7876606169875;4248.490181178278;4253.936190957138;5898.646081235097;5917.08285215788;5921.052631578969;5930.110483427477;5934.13954976526;5483.561315094783;5517.972410137923;5551.611387202897;5574.358948720908;5589;6532.510061745341;6567.113439685629;6572.047053177263;6585.604863708145;6632.8673426531195;4664.043871006469;4665.740250132445;4666.743329116897;4669.439667239919;4675.719456832567;6691.096701945273;6918.93081069193;6927.826804329881;6928.61892595907;6966.582005079711;4681.274402467623;4695.671303008825;4701.459332176775;4701.717896926195;4715.693479923794;4763.499832517605;4764.4520880098535;4766.594839438687;4771.141194584939;4772.403449568804;5510.752016159283;5541.889162216733;5563.248961390242;5567.582431317586;5580.1629755537;6549.083128362033;6690.397864192246;6717.764878229336;6760.966195169091;6813.1142951415995;1655.6854197702398;1711.1700825099817;1714.0829656133908;1718.7937447506379;1729.1267909705518;1165.7726743285148;1175.8824117588345;1177.9705507362385;1184.922980006297;1185.3362117214388;6156.661383623944;6161.691915404212;6163.137160797492;6167.136600875881;6189.876202476015;6624.86750264992;6643.2360278568585;6658.800235992928;6681.599104053772;6721.4958878084335;6021.187139736079;6165.537584681167;6169.290531588925;6173.41352571505;6177.598456100339;3655.287218992324;3655.3054919565197;3668.8899333019517;3669.5596528416227;3672.8714494992546;7044.330788575077;7092.113485814273;7128.144622645315;7129.572225666477;7137.92862071383;6752.257251702309;6904.171499420102;6924.099867017256;6929.411000065051;6965.547239429421;7084.716611335592;7102.254263302382;7107.111611048619;7112.715491380287;7120.1099862517185;6697.3637504437;6707.698153583003;6711.697973591297;6741.966290168518;6767.526273160832;6534.215894092739;6642.236142843635;6673.1992160941;6675.7997260082275;6688.6990085445295;7109.4667899908745;7121.572705637678;7135.322144396274;7136.7145314186855;7145.21402645719;4695.4834968154155;4709.0346478972415;4714.976425117852;4723.551262630044;4733.644976626836;6690.732370705117;6778.32216778338;6780.084688566981;6786.3892249697765;7001.404880585003;6690.163729533809;6691.866162676816;6711.463082953254;6739.0902228198565;6764.5603035802515;6646.90029649546;6692.732290708317;6693.330666933462;6695.363940425652;6708.26209116987;6460.321666224979;6593.109930159559;6619.4373478252965;6634.336566343327;6635.2037755469655;6639.601623902581;6666.866662666623;6726.596404215763;6747.527673063035;6786.796396108125;6565.606063636006;6586.868262634816;6589.17635295588;6600.933990660032;6617.735290588323 11:05:04 INFO - PROCESS | 31915 | |5;yui.html;749.3106342165211;772.7488566215981;788.996055019725;802.2218448105338;832.6003518311211;12894.226346419222;13158.671033224175;13161.802572961402;13166.868331316684;13194.53819116331;11573.074154067675;12478.81281780774;12545.68635784106;12822.166559173671;12828.230306181613;787.1970589998199;792.6353877216487;798.2217338095369;799.1928152565921;803.1767438375682;797.3421926910294;799.7121036426881;801.4590151647615;807.1726480357622;811.0834756724922;843.1989609870617;846.5894041389921;849.3120572336427;849.723839752083;851.4635779458932;839.9118092600311;840.5923127283263;840.7099550655014;846.238385453091;847.8728190771403;618.3352895637208;619.2630769384418;619.4332186049759;621.4251817069193;622.5331001748689;11275.943620281847;11337.206395552315;11385.146114041398;11392.430378481044;11457.484413201426;11116.888831111666;11255.155863310285;11294.717632059183;11386.487608057658;11659.300441973508;8343.16568343167;8382.958085209595;8580.013298470692;8715.389922705413;8733.7816554586;3496.4230901901155;3527.7883327000204;3542.574891013069;3635.000374896898;3641.6904563112166;44413.77793111046;44875.55124448746;46610;49712;49788;10258.58965641366;10336.328138670962;10500;10538.525766340534;10731.83902241467;18652.906735466237;18823.623527529373;18834;18874.056297185085;18943;7519.586422746692;7520.247975202436;7570.962145189349;7627.351675107567;7736.226377362219;3904.96095039046;3975.4235635832642;4053.493313335833;4071.4096456014304;4089.284375234322;2971.9108426747234;2974.2415684000443;2982.0904624089862;2990.7756918230784;2995.550667399864;555.5694336888944;567.5799908068;574.1789241384777;578.9189513468118;580.5471732049009;480.75000999480073;522.3548917087394;571.8513186571521;578.1068249554448;666.7166454256921;7863.9213607863185;8181.18188181189;8262.132476090044;8364.707235246737;8397.28623067034;565.6125553995527;611.1993288791697;661.9966900165468;689.7654797368918;698.7309885694044;4073.877783666495;4104.753714777064;4110.609492098246;4138.6482149017065;4193.098483825931;55931;56242.71878640662;56369.43630563642;57003.42996570064;57428.425715742305;49799.75100124476;50688;51077;51209.48790512122;51427.485725143015;39666;45882.85292867705;50402.49597504051;51015.489845101074;51887.74056129695;8875;8937.73186804397;8970.686025989058;9240.311616136609;9251.491167985825;33563;33810.3237935235;34135.829320853234;34405.311893761485;34890.82554587211;42375.57624423716;42962.78518607387;43013.13973720445;43939.56060439483;43978.56021439873;10219.7445063874;10234.283600148216;10360.378377297386;10487.79024419492;11298.548058077586;10621.15030797519;10643.308184967953;10662.413567253876;10673.786524269626;11225.494852731483;11362.772744544898;11441.599544015919;11533.711657208636;11855.703607409883;12075.456604452645;10802.783944320912;11010.779784404427;11152.16358773079;11309.321440713584;11363.715907102058;11306.660800176009;11306.660800176009;11385;11512.59705910289;11901.940490297493;9413.858792117986;9688.46713430768;10026.899731002597;10040.196784257096;10199.337043092175;9495.28785341116;9560.904390956;9644.276679248944;9675.70972870815;9827.557759900965 11:05:04 INFO - PROCESS | 31915 | __end_tp_report 11:05:04 INFO - PROCESS | 31915 | __start_cc_report 11:05:04 INFO - PROCESS | 31915 | _x_x_mozilla_cycle_collect,308 11:05:04 INFO - PROCESS | 31915 | __end_cc_report 11:05:04 INFO - PROCESS | 31915 | __startTimestamp1453489504338__endTimestamp 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | ------- Summary: start ------- 11:05:04 INFO - PROCESS | 31915 | Number of tests: 6 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#0] dojo.html Cycles:165 Average:5293.74 Median:5494.73 stddev:568.81 (10.4%) stddev-sans-first:547.00 11:05:04 INFO - PROCESS | 31915 | Values: 3228.7 3234.2 3245.2 3293.4 3293.9 5136.8 5323.3 5325.8 5327.9 5332.9 5150.3 5295.7 5317.7 5327.3 5346.9 4520.9 4761.1 4933.5 4960.9 4974.6 4710.7 4873.0 4898.5 4929.3 4936.2 4785.9 4801.7 4839.1 4869.5 4907.7 4870.8 4881.1 4893.9 4915.0 4930.1 4725.3 4776.1 4877.9 4887.8 4916.9 5161.5 5176.1 5188.5 5197.5 5206.4 5660.7 5661.5 5679.2 5694.7 5701.2 5615.6 5726.8 5734.2 5751.4 5773.7 5378.4 5437.3 5447.8 5467.1 5504.3 5755.6 5780.3 5794.8 5795.2 5817.9 5502.5 5585.9 5614.1 5615.1 5615.5 5749.5 5795.1 5799.8 5804.4 5859.9 5602.4 5650.2 5701.7 5709.7 5722.5 5517.5 5613.6 5676.0 5717.3 5731.9 4413.4 4449.2 4452.9 4456.1 4457.4 3968.2 3978.3 3979.8 4012.0 4028.8 5180.2 5230.9 5302.5 5311.6 5333.7 5674.4 5688.1 5719.1 5721.2 5744.2 5318.1 5322.3 5324.1 5326.8 5390.6 4784.6 4848.3 4859.6 4883.3 4957.8 5800.1 5817.9 5824.5 5842.1 5856.6 5567.6 5588.9 5601.4 5609.2 5637.8 5756.7 5889.8 5908.3 5924.9 5930.9 5663.6 5665.1 5667.6 5673.2 5673.6 5563.5 5637.8 5685.8 5734.6 5742.1 5585.0 5629.5 5634.7 5637.4 5679.1 5573.2 5591.1 5592.2 5614.6 5616.4 5300.0 5374.4 5389.4 5532.7 5551.8 5456.1 5641.5 5723.8 5725.5 5768.0 5421.9 5427.5 5434.9 5440.3 5494.7 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#1] ext.html Cycles:180 Average:44190.99 Median:33068.58 stddev:76127.88 (230.2%) stddev-sans-first:76270.77 11:05:04 INFO - PROCESS | 31915 | Values: 501.9 521.0 531.4 541.3 552.5 33908.5 34275.0 34362.0 34410.0 34550.0 35529.0 35963.0 35974.6 36140.6 36165.3 8053.4 8239.0 8259.6 8281.4 8304.4 8027.4 8328.1 8336.6 8346.4 8357.8 8306.7 8331.5 8408.0 8430.1 8454.1 8329.1 8337.7 8384.9 8406.1 8418.7 8153.8 8281.6 8283.2 8285.4 8292.7 34766.1 34864.0 34907.8 35138.8 35190.8 2773.9 2777.6 2785.1 2788.6 3079.2 28472.6 28698.6 28841.4 28966.6 29018.9 3762.3 3902.7 3945.4 3983.7 4107.5 249461.0 251042.0 252279.0 252294.0 252792.0 49952.3 50513.5 55127.0 55559.6 55595.7 60023.0 60315.0 60558.0 60947.7 61087.0 14542.2 14783.5 14803.6 14888.4 14910.2 11052.7 11076.2 11167.5 11177.2 11206.8 17950.8 18373.0 18389.7 18476.8 19038.4 7481.5 7694.4 7740.5 7757.2 7777.7 889.7 1024.7 1053.7 1106.1 1114.4 27872.0 28387.3 28435.9 28592.0 28782.9 975.5 987.6 994.5 1012.1 1034.8 13008.4 13169.6 13189.7 13338.1 13611.4 315440.0 316257.0 316381.0 319560.0 321515.0 47337.5 47560.5 47782.0 47905.3 47964.5 1314.8 1326.3 1338.8 1347.7 1349.3 23963.6 24440.0 24841.6 24997.9 25085.0 37999.6 38166.8 38357.6 38412.2 38631.2 297348.5 297771.0 298112.0 299191.0 299418.0 29374.9 30687.4 31939.2 32062.5 32099.0 36426.3 36876.0 37067.3 37104.9 37169.0 30479.7 31257.8 31397.7 32066.2 32144.7 33734.3 34057.0 34169.8 34455.1 35528.3 30843.5 31436.5 31821.7 31836.0 31935.8 27595.0 28772.9 31022.0 32397.5 32402.8 22397.1 22401.7 22453.4 22490.2 22609.3 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#2] jquery.html Cycles:180 Average:25961.07 Median:61688.54 stddev:75762.68 (122.8%) stddev-sans-first:75950.83 11:05:04 INFO - PROCESS | 31915 | Values: 361.5 361.7 364.4 366.9 368.1 15495.7 15972.2 16205.7 16767.5 17128.2 10754.9 10996.0 15978.8 16466.4 16534.9 4868.7 6492.1 6677.8 6759.3 6763.7 6539.3 6716.3 6728.0 6886.3 6890.4 6178.2 6432.9 6452.5 6818.8 6898.6 6224.9 6280.5 6375.8 6731.3 6739.9 6255.7 6405.2 6442.5 6480.1 6613.6 20879.6 21505.6 21678.0 21832.1 22564.5 2238.7 2253.5 2255.1 2265.4 2308.5 10296.4 13537.3 13731.8 13802.3 14061.6 1758.3 1812.7 1832.9 1891.5 1975.4 60658.0 61220.7 61441.7 61676.4 61700.7 14770.2 14973.8 15003.5 15029.6 15218.9 23231.9 23451.3 23569.8 23620.4 23697.5 8401.7 8460.4 8621.7 8632.0 8642.0 7105.2 7138.6 7281.8 7302.3 7332.7 7365.6 7434.0 7466.4 7540.2 7541.8 1797.5 1817.9 1873.1 2936.9 3070.1 909.9 933.8 977.7 985.3 990.6 15609.5 16365.5 16383.3 16550.0 16562.5 846.0 873.6 889.8 928.5 945.0 8719.7 8753.8 8983.9 9011.2 9035.7 373268.0 381540.0 510497.0 510681.0 518308.0 62664.7 64048.0 69285.7 71386.0 73977.0 1142.6 1159.5 1165.8 1175.4 1186.0 14852.8 15021.1 15112.4 15181.6 15363.4 31595.5 32018.7 32496.5 32521.3 33533.0 42429.7 42651.0 42728.6 43302.4 43377.3 7161.1 7255.7 7298.4 7466.1 7516.2 10181.4 10360.8 10896.4 10970.8 11111.8 9040.0 9042.0 9233.2 9273.9 9336.3 9535.3 9653.4 9681.1 9749.0 9865.0 8880.2 9357.0 9428.2 9547.2 9598.5 7207.2 7276.9 7327.5 7335.8 7399.5 3210.6 7921.9 8609.7 8717.4 9339.0 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#3] mootools.html Cycles:180 Average:5363.37 Median:6407.49 stddev:2762.58 (43.1%) stddev-sans-first:2754.88 11:05:04 INFO - PROCESS | 31915 | Values: 1475.9 1503.6 1674.1 1757.8 1795.3 7379.5 7595.0 7610.4 7768.4 7809.7 7746.5 7766.0 7825.8 7851.3 7852.0 2284.4 2296.7 2328.4 2331.1 2335.4 2380.6 2389.3 2390.9 2418.6 2422.3 2282.6 2312.9 2319.6 2355.3 2358.7 2338.4 2347.4 2361.7 2372.5 2379.3 2363.1 2374.2 2387.8 2394.8 2395.9 7732.1 7812.4 7813.4 7814.9 7830.3 4723.3 4805.0 4832.6 4835.4 4842.9 2974.1 3016.5 3030.3 3048.3 3092.1 936.9 951.7 969.4 990.0 991.8 10570.6 10645.1 10706.6 10720.4 10728.1 4205.3 4215.0 4278.4 4292.7 4388.8 8704.1 8738.0 8740.4 8746.7 8798.2 4822.3 4843.0 4876.4 4882.4 4888.0 4433.8 4445.2 4469.2 4482.2 4492.8 3556.0 3563.8 3586.1 3601.2 3602.9 1014.4 1090.6 1101.9 1114.0 1117.1 972.5 1016.8 1059.9 1064.6 1216.2 6805.0 6900.6 6906.0 6915.4 6931.4 619.4 630.6 633.7 634.4 745.2 5369.4 5385.4 5410.0 5411.6 5445.6 8783.6 8960.7 9175.6 9261.3 9280.8 9117.0 9161.2 9162.5 9172.7 9219.0 6872.8 7016.8 7088.6 7108.9 7223.5 6964.4 6999.6 7011.9 7018.4 7042.5 8167.8 8199.3 8305.5 8325.8 8382.2 8400.2 8609.0 8624.4 8644.7 8660.4 6278.4 6606.5 6830.2 6845.1 6861.2 7208.0 7216.7 7262.4 7283.5 7290.5 5970.3 6631.8 6738.2 6813.5 6993.0 6724.4 6745.7 6799.8 6847.1 6884.6 6473.2 6595.2 6610.5 6623.2 6631.8 6403.7 6411.3 6454.3 6461.6 6476.9 6229.4 6302.1 6309.6 6337.7 6383.0 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#4] prototype.html Cycles:180 Average:5541.29 Median:6174.70 stddev:1653.37 (26.8%) stddev-sans-first:1611.46 11:05:04 INFO - PROCESS | 31915 | Values: 350.7 353.9 355.0 356.0 357.6 6116.0 6116.1 6176.0 6234.0 6248.6 6118.2 6206.4 6244.8 6247.1 6264.8 4760.7 4793.5 4806.4 4807.4 4819.6 4806.3 4820.7 4840.8 4853.3 4855.8 4710.7 4802.2 4806.2 4816.7 4817.0 4793.2 4795.3 4800.8 4812.7 4822.7 4199.2 4229.4 4246.8 4248.5 4253.9 5898.6 5917.1 5921.1 5930.1 5934.1 5483.6 5518.0 5551.6 5574.4 5589.0 6532.5 6567.1 6572.0 6585.6 6632.9 4664.0 4665.7 4666.7 4669.4 4675.7 6691.1 6918.9 6927.8 6928.6 6966.6 4681.3 4695.7 4701.5 4701.7 4715.7 4763.5 4764.5 4766.6 4771.1 4772.4 5510.8 5541.9 5563.2 5567.6 5580.2 6549.1 6690.4 6717.8 6761.0 6813.1 1655.7 1711.2 1714.1 1718.8 1729.1 1165.8 1175.9 1178.0 1184.9 1185.3 6156.7 6161.7 6163.1 6167.1 6189.9 6624.9 6643.2 6658.8 6681.6 6721.5 6021.2 6165.5 6169.3 6173.4 6177.6 3655.3 3655.3 3668.9 3669.6 3672.9 7044.3 7092.1 7128.1 7129.6 7137.9 6752.3 6904.2 6924.1 6929.4 6965.5 7084.7 7102.3 7107.1 7112.7 7120.1 6697.4 6707.7 6711.7 6742.0 6767.5 6534.2 6642.2 6673.2 6675.8 6688.7 7109.5 7121.6 7135.3 7136.7 7145.2 4695.5 4709.0 4715.0 4723.6 4733.6 6690.7 6778.3 6780.1 6786.4 7001.4 6690.2 6691.9 6711.5 6739.1 6764.6 6646.9 6692.7 6693.3 6695.4 6708.3 6460.3 6593.1 6619.4 6634.3 6635.2 6639.6 6666.9 6726.6 6747.5 6786.8 6565.6 6586.9 6589.2 6600.9 6617.7 11:05:04 INFO - PROCESS | 31915 | 11:05:04 INFO - PROCESS | 31915 | [#5] yui.html Cycles:180 Average:13525.86 Median:45379.20 stddev:15823.29 (34.9%) stddev-sans-first:15838.59 11:05:04 INFO - PROCESS | 31915 | Values: 749.3 772.7 789.0 802.2 832.6 12894.2 13158.7 13161.8 13166.9 13194.5 11573.1 12478.8 12545.7 12822.2 12828.2 787.2 792.6 798.2 799.2 803.2 797.3 799.7 801.5 807.2 811.1 843.2 846.6 849.3 849.7 851.5 839.9 840.6 840.7 846.2 847.9 618.3 619.3 619.4 621.4 622.5 11275.9 11337.2 11385.1 11392.4 11457.5 11116.9 11255.2 11294.7 11386.5 11659.3 8343.2 8383.0 8580.0 8715.4 8733.8 3496.4 3527.8 3542.6 3635.0 3641.7 44413.8 44875.6 46610.0 49712.0 49788.0 10258.6 10336.3 10500.0 10538.5 10731.8 18652.9 18823.6 18834.0 18874.1 18943.0 7519.6 7520.2 7571.0 7627.4 7736.2 3905.0 3975.4 4053.5 4071.4 4089.3 2971.9 2974.2 2982.1 2990.8 2995.6 555.6 567.6 574.2 578.9 580.5 480.8 522.4 571.9 578.1 666.7 7863.9 8181.2 8262.1 8364.7 8397.3 565.6 611.2 662.0 689.8 698.7 4073.9 4104.8 4110.6 4138.6 4193.1 55931.0 56242.7 56369.4 57003.4 57428.4 49799.8 50688.0 51077.0 51209.5 51427.5 39666.0 45882.9 50402.5 51015.5 51887.7 8875.0 8937.7 8970.7 9240.3 9251.5 33563.0 33810.3 34135.8 34405.3 34890.8 42375.6 42962.8 43013.1 43939.6 43978.6 10219.7 10234.3 10360.4 10487.8 11298.5 10621.2 10643.3 10662.4 10673.8 11225.5 11362.8 11441.6 11533.7 11855.7 12075.5 10802.8 11010.8 11152.2 11309.3 11363.7 11306.7 11306.7 11385.0 11512.6 11901.9 9413.9 9688.5 10026.9 10040.2 10199.3 9495.3 9560.9 9644.3 9675.7 9827.6 11:05:04 INFO - PROCESS | 31915 | -------- Summary: end -------- 11:05:04 INFO - PROCESS | 31915 | 11:05:05 INFO - TEST-INFO | 31915: exit 0 11:05:05 INFO - TEST-OK | dromaeo_css | took 1110921ms 11:05:05 INFO - TEST-START | kraken 11:05:05 INFO - operating with platform_type : linux_ 11:05:05 INFO - Initialising browser for kraken test... 11:05:05 INFO - TEST-INFO | started process 32155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5PezKc/profile http://localhost:59976/getInfo.html) 11:05:08 INFO - PROCESS | 32155 | 11:05:08 INFO - PROCESS | 32155 | (process:32228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:09 INFO - PROCESS | 32155 | __metrics Screen width/height:1600/1200 11:05:09 INFO - PROCESS | 32155 | colorDepth:24 11:05:09 INFO - PROCESS | 32155 | Browser inner width/height: 1024/697 11:05:09 INFO - PROCESS | 32155 | __metrics 11:05:09 INFO - PROCESS | 32155 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:05:10 INFO - TEST-INFO | 32155: exit 0 11:05:10 INFO - Browser initialized. 11:05:10 INFO - Running cycle 1/1 for kraken test... 11:05:10 INFO - TEST-INFO | started process 32277 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5PezKc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:11 INFO - PROCESS | 32277 | 11:05:11 INFO - PROCESS | 32277 | (process:32337): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:22 INFO - PROCESS | 32277 | RSS: Main: 150708224 11:05:22 INFO - PROCESS | 32277 | 11:05:24 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-beat-detection) 11:05:25 INFO - PROCESS | 32277 | RSS: Main: 156229632 11:05:25 INFO - PROCESS | 32277 | 11:05:28 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-dft) 11:05:28 INFO - PROCESS | 32277 | RSS: Main: 157691904 11:05:28 INFO - PROCESS | 32277 | 11:05:31 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-fft) 11:05:32 INFO - PROCESS | 32277 | RSS: Main: 151801856 11:05:32 INFO - PROCESS | 32277 | 11:05:34 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59976/tests/kraken/driver.html?testName=audio-oscillator) 11:05:34 INFO - PROCESS | 32277 | RSS: Main: 151195648 11:05:34 INFO - PROCESS | 32277 | 11:05:37 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:37 INFO - PROCESS | 32277 | RSS: Main: 152936448 11:05:37 INFO - PROCESS | 32277 | 11:05:40 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-darkroom) 11:05:41 INFO - PROCESS | 32277 | RSS: Main: 153350144 11:05:41 INFO - PROCESS | 32277 | 11:05:44 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59976/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:45 INFO - PROCESS | 32277 | RSS: Main: 151797760 11:05:45 INFO - PROCESS | 32277 | 11:05:48 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59976/tests/kraken/driver.html?testName=json-parse-financial) 11:05:48 INFO - PROCESS | 32277 | RSS: Main: 153931776 11:05:48 INFO - PROCESS | 32277 | 11:05:50 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:50 INFO - PROCESS | 32277 | RSS: Main: 155025408 11:05:50 INFO - PROCESS | 32277 | 11:05:52 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:53 INFO - PROCESS | 32277 | RSS: Main: 153821184 11:05:53 INFO - PROCESS | 32277 | 11:05:55 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:56 INFO - PROCESS | 32277 | RSS: Main: 154230784 11:05:56 INFO - PROCESS | 32277 | 11:05:58 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:59 INFO - PROCESS | 32277 | RSS: Main: 154017792 11:05:59 INFO - PROCESS | 32277 | 11:06:01 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:06:02 INFO - PROCESS | 32277 | RSS: Main: 155959296 11:06:02 INFO - PROCESS | 32277 | 11:06:03 INFO - PROCESS | 32277 | Cycle 1(1): loaded http://localhost:59976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59976/tests/kraken/driver.html?testName=ai-astar) 11:06:04 INFO - PROCESS | 32277 | RSS: Main: 155398144 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | __start_tp_report 11:06:04 INFO - PROCESS | 32277 | _x_x_mozilla_page_load 11:06:04 INFO - PROCESS | 32277 | _x_x_mozilla_page_load_details 11:06:04 INFO - PROCESS | 32277 | |i|pagename|runs| 11:06:04 INFO - PROCESS | 32277 | |0;ai-astar;113;108;112;113;115;123;113;110;111;115 11:06:04 INFO - PROCESS | 32277 | |1;audio-beat-detection;153;126;162;170;135;161;155;138;164;134 11:06:04 INFO - PROCESS | 32277 | |2;audio-dft;164;162;162;163;161;161;162;166;166;163 11:06:04 INFO - PROCESS | 32277 | |3;audio-fft;74;74;76;73;76;135;73;75;74;75 11:06:04 INFO - PROCESS | 32277 | |4;audio-oscillator;95;96;139;97;96;96;139;97;99;134 11:06:04 INFO - PROCESS | 32277 | |5;imaging-gaussian-blur;110;110;110;110;109;110;110;110;109;110 11:06:04 INFO - PROCESS | 32277 | |6;imaging-darkroom;146;146;149;146;147;146;148;148;147;146 11:06:04 INFO - PROCESS | 32277 | |7;imaging-desaturate;96;98;97;97;99;96;96;97;97;97 11:06:04 INFO - PROCESS | 32277 | |8;json-parse-financial;63;62;65;62;60;61;62;59;61;59 11:06:04 INFO - PROCESS | 32277 | |9;json-stringify-tinderbox;68;69;67;68;68;68;68;68;69;68 11:06:04 INFO - PROCESS | 32277 | |10;stanford-crypto-aes;86;85;85;91;83;84;85;84;84;87 11:06:04 INFO - PROCESS | 32277 | |11;stanford-crypto-ccm;113;126;122;128;119;118;129;122;119;118 11:06:04 INFO - PROCESS | 32277 | |12;stanford-crypto-pbkdf2;145;145;156;141;143;141;144;144;144;136 11:06:04 INFO - PROCESS | 32277 | |13;stanford-crypto-sha256-iterative;66;68;66;69;67;66;68;67;69;68 11:06:04 INFO - PROCESS | 32277 | __end_tp_report 11:06:04 INFO - PROCESS | 32277 | __start_cc_report 11:06:04 INFO - PROCESS | 32277 | _x_x_mozilla_cycle_collect,751 11:06:04 INFO - PROCESS | 32277 | __end_cc_report 11:06:04 INFO - PROCESS | 32277 | __startTimestamp1453489564224__endTimestamp 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | ------- Summary: start ------- 11:06:04 INFO - PROCESS | 32277 | Number of tests: 14 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 11:06:04 INFO - PROCESS | 32277 | Values: 113.0 108.0 112.0 113.0 115.0 123.0 113.0 110.0 111.0 115.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:158.00 stddev:15.26 (9.7%) stddev-sans-first:16.14 11:06:04 INFO - PROCESS | 32277 | Values: 153.0 126.0 162.0 170.0 135.0 161.0 155.0 138.0 164.0 134.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.83 (1.1%) stddev-sans-first:1.90 11:06:04 INFO - PROCESS | 32277 | Values: 164.0 162.0 162.0 163.0 161.0 161.0 162.0 166.0 166.0 163.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:19.18 (25.7%) stddev-sans-first:20.20 11:06:04 INFO - PROCESS | 32277 | Values: 74.0 74.0 76.0 73.0 76.0 135.0 73.0 75.0 74.0 75.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:19.76 (20.6%) stddev-sans-first:20.32 11:06:04 INFO - PROCESS | 32277 | Values: 95.0 96.0 139.0 97.0 96.0 96.0 139.0 97.0 99.0 134.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:06:04 INFO - PROCESS | 32277 | Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 11:06:04 INFO - PROCESS | 32277 | Values: 146.0 146.0 149.0 146.0 147.0 146.0 148.0 148.0 147.0 146.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 11:06:04 INFO - PROCESS | 32277 | Values: 96.0 98.0 97.0 97.0 99.0 96.0 96.0 97.0 97.0 97.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.00 stddev:1.84 (3.0%) stddev-sans-first:1.86 11:06:04 INFO - PROCESS | 32277 | Values: 63.0 62.0 65.0 62.0 60.0 61.0 62.0 59.0 61.0 59.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 11:06:04 INFO - PROCESS | 32277 | Values: 68.0 69.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.27 (2.7%) stddev-sans-first:2.40 11:06:04 INFO - PROCESS | 32277 | Values: 86.0 85.0 85.0 91.0 83.0 84.0 85.0 84.0 84.0 87.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.00 stddev:5.04 (4.1%) stddev-sans-first:4.33 11:06:04 INFO - PROCESS | 32277 | Values: 113.0 126.0 122.0 128.0 119.0 118.0 129.0 122.0 119.0 118.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:144.00 stddev:5.04 (3.5%) stddev-sans-first:5.33 11:06:04 INFO - PROCESS | 32277 | Values: 145.0 145.0 156.0 141.0 143.0 141.0 144.0 144.0 144.0 136.0 11:06:04 INFO - PROCESS | 32277 | 11:06:04 INFO - PROCESS | 32277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.13 11:06:04 INFO - PROCESS | 32277 | Values: 66.0 68.0 66.0 69.0 67.0 66.0 68.0 67.0 69.0 68.0 11:06:04 INFO - PROCESS | 32277 | -------- Summary: end -------- 11:06:04 INFO - PROCESS | 32277 | 11:06:05 INFO - TEST-INFO | 32277: exit 0 11:06:05 INFO - TEST-OK | kraken | took 60166ms 11:06:05 INFO - TEST-START | v8_7 11:06:05 INFO - operating with platform_type : linux_ 11:06:05 INFO - Initialising browser for v8_7 test... 11:06:05 INFO - TEST-INFO | started process 32565 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBe2N19/profile http://localhost:59976/getInfo.html) 11:06:08 INFO - PROCESS | 32565 | 11:06:08 INFO - PROCESS | 32565 | (process:32637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:06:09 INFO - PROCESS | 32565 | __metrics Screen width/height:1600/1200 11:06:09 INFO - PROCESS | 32565 | colorDepth:24 11:06:09 INFO - PROCESS | 32565 | Browser inner width/height: 1024/697 11:06:09 INFO - PROCESS | 32565 | __metrics 11:06:09 INFO - PROCESS | 32565 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:06:10 INFO - TEST-INFO | 32565: exit 0 11:06:10 INFO - Browser initialized. 11:06:10 INFO - Running cycle 1/1 for v8_7 test... 11:06:10 INFO - TEST-INFO | started process 32686 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBe2N19/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:12 INFO - PROCESS | 32686 | 11:06:12 INFO - PROCESS | 32686 | (process:32747): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:06:22 INFO - PROCESS | 32686 | RSS: Main: 152276992 11:06:22 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | Cycle 1(1): loaded http://localhost:59976/tests/v8_7/run.html (next: http://localhost:59976/tests/v8_7/run.html) 11:06:45 INFO - PROCESS | 32686 | RSS: Main: 151134208 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | __start_tp_report 11:06:45 INFO - PROCESS | 32686 | _x_x_mozilla_page_load 11:06:45 INFO - PROCESS | 32686 | _x_x_mozilla_page_load_details 11:06:45 INFO - PROCESS | 32686 | |i|pagename|runs| 11:06:45 INFO - PROCESS | 32686 | |0;Richards;166.05778811026238 11:06:45 INFO - PROCESS | 32686 | |1;DeltaBlue;190.91256204658268 11:06:45 INFO - PROCESS | 32686 | |2;Encrypt;280.74115665356544 11:06:45 INFO - PROCESS | 32686 | |3;Decrypt;5202.072538860104 11:06:45 INFO - PROCESS | 32686 | |4;RayTrace;1082.2510822510822 11:06:45 INFO - PROCESS | 32686 | |5;Earley;744.047619047619 11:06:45 INFO - PROCESS | 32686 | |6;Boyer;12341.463414634147 11:06:45 INFO - PROCESS | 32686 | |7;RegExp;41428.57142857143 11:06:45 INFO - PROCESS | 32686 | |8;Splay;610.5006105006105 11:06:45 INFO - PROCESS | 32686 | |9;NavierStokes;4859.223300970873 11:06:45 INFO - PROCESS | 32686 | __end_tp_report 11:06:45 INFO - PROCESS | 32686 | __startTimestamp1453489605340__endTimestamp 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | ------- Summary: start ------- 11:06:45 INFO - PROCESS | 32686 | Number of tests: 10 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 166.1 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#1] DeltaBlue Cycles:1 Average:190.91 Median:190.91 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 190.9 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 280.7 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 5202.1 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 1082.3 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#5] Earley Cycles:1 Average:744.05 Median:744.05 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 744.0 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 12341.5 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#7] RegExp Cycles:1 Average:41428.57 Median:41428.57 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 41428.6 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#8] Splay Cycles:1 Average:610.50 Median:610.50 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 610.5 11:06:45 INFO - PROCESS | 32686 | 11:06:45 INFO - PROCESS | 32686 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 11:06:45 INFO - PROCESS | 32686 | Values: 4859.2 11:06:45 INFO - PROCESS | 32686 | -------- Summary: end -------- 11:06:45 INFO - PROCESS | 32686 | 11:06:46 INFO - TEST-INFO | 32686: exit 0 11:06:46 INFO - TEST-OK | v8_7 | took 41051ms 11:06:46 INFO - SUITE-END | took 1212s 11:06:46 INFO - Completed test suite (00:20:12) 11:06:46 INFO - Working with test: dromaeo_css 11:06:46 INFO - Generating results file: dromaeo_css 11:06:46 INFO - Working with test: kraken 11:06:46 INFO - Generating results file: kraken 11:06:46 INFO - javascript benchmark 11:06:46 INFO - Working with test: v8_7 11:06:46 INFO - Generating results file: v8_7 11:06:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:06:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:06:46 INFO - process_Request line: dromaeo_css 6894.49 graph.html#tests=[[72,64,43]] 11:06:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:06:46 INFO - process_Request line: kraken 1516.70 graph.html#tests=[[232,64,43]] 11:06:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:06:46 INFO - process_Request line: v8_7 20177.28 graph.html#tests=[[230,64,43]] 11:06:46 INFO - RETURN: dromaeo_css: 6894.49 11:06:46 INFO - RETURN: kraken: 1516.70 11:06:46 INFO - RETURN: v8_7: 20177.28 11:06:46 INFO - javascript benchmark 11:06:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3228.6609905959876, 3234.1591186291557, 3245.204924793426, 3293.4071867063935, 3293.9176520587, 5136.794528218876, 5323.281357016802, 5325.760340784665, 5327.946720532794, 5332.920006199901, 5150.330457040589, 5295.735213239342, 5317.654352467087, 5327.334083239595, 5346.91979620305, 4520.864374068783, 4761.14299426104, 4933.506649335056, 4960.875978100558, 4974.552290293873, 4710.670253082286, 4872.975635121819, 4898.534639209287, 4929.260610908356, 4936.210206366982, 4785.928211076836, 4801.735904525267, 4839.080574690833, 4869.5130486951375, 4907.730074845882, 4870.7564621769125, 4881.072596206709, 4893.8776530586665, 4914.992426552584, 4930.137225985438, 4725.3384526166365, 4776.09254241693, 4877.853664390039, 4887.780049897728, 4916.8770780730765, 5161.483851614846, 5176.094183517869, 5188.481151884819, 5197.506236907488, 5206.401263854629, 5660.688662123582, 5661.547076233933, 5679.233303504016, 5694.658320500783, 5701.230333904911, 5615.634983726045, 5726.828195154152, 5734.225879506255, 5751.367349591584, 5773.740181691834, 5378.435264297232, 5437.34751829783, 5447.836564903059, 5467.0705979983495, 5504.284443022421, 5755.5683323750045, 5780.277465316835, 5794.797182098607, 5795.159701843293, 5817.912731309034, 5502.477264659851, 5585.8603534911135, 5614.07367784311, 5615.073512870413, 5615.466530679579, 5749.540036797046, 5795.072788353843, 5799.826005219766, 5804.448577385142, 5859.9121013183985, 5602.38373778884, 5650.152477128464, 5701.657900525982, 5709.714514274269, 5722.456366645162, 5517.503424691797, 5613.635113717677, 5676.0, 5717.313922329347, 5731.856703582361, 4413.360062790942, 4449.243628583149, 4452.9109417812115, 4456.086502267028, 4457.398251236042, 3968.1865217630316, 3978.3236849735613, 3979.781112038808, 4011.9799401003393, 4028.7582745035393, 5180.222966555047, 5230.947690523122, 5302.549283310885, 5311.628186027018, 5333.679979201261, 5674.432556744293, 5688.089905615082, 5719.142128680731, 5721.199032135504, 5744.195812586241, 5318.149096144675, 5322.2548843161985, 5324.121519949243, 5326.7869285228935, 5390.595705322038, 4784.617230621611, 4848.321235027099, 4859.586935110555, 4883.267509873476, 4957.801687932514, 5800.1299805029585, 5817.912731309034, 5824.475797178189, 5842.065269556851, 5856.648601083949, 5567.5545956322585, 5588.944110558842, 5601.439856014366, 5609.214709940693, 5637.830865074055, 5756.65460072397, 5889.793857214977, 5908.261467316585, 5924.8815023700145, 5930.9110363343725, 5663.631863928831, 5665.12190610456, 5667.574931880043, 5673.234113394639, 5673.602847800615, 5563.471470210324, 5637.774489020558, 5685.800996965087, 5734.627249228787, 5742.109972954198, 5585.022621041383, 5629.549636029026, 5634.7464364104535, 5637.43625637433, 5679.119736440858, 5573.191887176417, 5591.077472217201, 5592.161175823659, 5614.606977511535, 5616.354119276336, 5300.0, 5374.4088150304215, 5389.407165211902, 5532.6680399176175, 5551.750171242223, 5456.099743542271, 5641.464060914206, 5723.828285151452, 5725.513331366714, 5767.971160144172, 5421.945780542144, 5427.457254274541, 5434.918476222781, 5440.265564148789, 5494.725263736717], "unit": "score", "name": "dojo.html", "value": 5258.497340223281}, {"lowerIsBetter": false, "replicates": [501.88707540803324, 520.9687418754875, 531.3835950297654, 541.3098299667923, 552.5082676417986, 33908.491372629396, 34275.0, 34362.0, 34410.0, 34550.0, 35529.0, 35963.0, 35974.640253597456, 36140.63859361406, 36165.2766944661, 8053.395995300347, 8238.958805205966, 8259.628316725762, 8281.37889658275, 8304.418690691655, 8027.3578113751055, 8328.125546817588, 8336.583170841433, 8346.41575089744, 8357.832843343129, 8306.667733290662, 8331.541765202912, 8407.957960210191, 8430.072692003874, 8454.070052294242, 8329.08380078191, 8337.708180213695, 8384.8742268866, 8406.075331713506, 8418.705345312885, 8153.7553873383895, 8281.585920703941, 8283.17168283173, 8285.42002059856, 8292.668293268262, 34766.13084672878, 34864.0, 34907.82546087279, 35138.824305878305, 35190.82404587986, 2773.9029133980416, 2777.5555911054335, 2785.1087651951384, 2788.5817127430846, 3079.230192451887, 28472.572911406347, 28698.569521457193, 28841.423171536662, 28966.565501517493, 29018.854905725337, 3762.3039737648623, 3902.6682731967817, 3945.3884647879627, 3983.701222408302, 4107.466029416187, 249461.0, 251042.0, 252279.0, 252294.0, 252792.0, 49952.25071623929, 50513.494865051616, 55127.0, 55559.61100972508, 55595.722021389636, 60023.0, 60315.0, 60558.0, 60947.69526152341, 61087.0, 14542.200178990046, 14783.482578109715, 14803.555893323217, 14888.404463821325, 14910.179940103399, 11052.668419947415, 11076.224664273584, 11167.497462614201, 11177.161712871568, 11206.831897521544, 17950.820491795177, 18373.0, 18389.724154137697, 18476.815231847508, 19038.428847134608, 7481.513701609378, 7694.422918281151, 7740.458167928304, 7757.224277572311, 7777.688892444239, 889.7197382824389, 1024.6721049264313, 1053.7312985188728, 1106.1095817866694, 1114.3536748685742, 27872.0, 28387.290317742223, 28435.85782071118, 28592.0, 28782.85608571944, 975.5268694683073, 987.5852142100335, 994.547480896205, 1012.119456073221, 1034.8292531732332, 13008.414621342063, 13169.604911852659, 13189.670258243621, 13338.066335356432, 13611.387487563083, 315440.0, 316257.0, 316381.0, 319560.0, 321515.0, 47337.526624734004, 47560.5243947563, 47782.0, 47905.281420778716, 47964.5203547967, 1314.8159257703928, 1326.2639235224542, 1338.7657159997157, 1347.690031292808, 1349.2579081505132, 23963.640545391485, 24440.0, 24841.627375589018, 24997.87501062483, 25085.0, 37999.62000379961, 38166.80916595399, 38357.61642383652, 38412.23175536418, 38631.227375452894, 297348.5132574323, 297771.0, 298112.0, 299191.0, 299418.0, 29374.853125734233, 30687.386252274384, 31939.201519961258, 32062.519062213618, 32099.0, 36426.27147457089, 36876.0, 37067.25865482621, 37104.918458968954, 37169.0, 30479.695203047686, 31257.8437107813, 31397.686023139475, 32066.19834504156, 32144.67855321417, 33734.32531349408, 34057.0, 34169.829150854086, 34455.13862153366, 35528.289434211685, 30843.537346939363, 31436.528452073693, 31821.681783182798, 31836.0, 31935.84032079825, 27595.0, 28772.856135719187, 31022.0, 32397.51403728993, 32402.83798580992, 22397.067370020777, 22401.66397504006, 22453.438664032878, 22490.21284255043, 22609.321720348416], "unit": "score", "name": "ext.html", "value": 17249.98961280974}, {"lowerIsBetter": false, "replicates": [361.45600870689606, 361.6510067784589, 364.44786148984286, 366.86426022371717, 368.08163631738813, 15495.690086198283, 15972.2013899305, 16205.675886482264, 16767.49697509075, 17128.229229684664, 10754.946225268863, 10996.02147017095, 15978.84021159788, 16466.423675171372, 16534.917325413386, 4868.707877527342, 6492.123563318963, 6677.833054173636, 6759.290274521179, 6763.66181690916, 6539.280679125316, 6716.261211266757, 6727.966360168192, 6886.311368863124, 6890.379865812076, 6178.165947597085, 6432.871342573146, 6452.548321617489, 6818.829529261783, 6898.551594146389, 6224.906626400608, 6280.466160376373, 6375.776847810304, 6731.259561448237, 6739.865202695968, 6255.655938923357, 6405.19935008124, 6442.452391546724, 6480.092787009822, 6613.57808071267, 20879.582408351747, 21505.5698886023, 21678.0, 21832.126714931383, 22564.548709025727, 2238.675392068141, 2253.4929640830846, 2255.12050300383, 2265.4223173090754, 2308.4805918668335, 10296.433696146709, 13537.255450950193, 13731.794023089662, 13802.309884505734, 14061.64845878851, 1758.3054693396166, 1812.673718730628, 1832.908354582279, 1891.4798430431604, 1975.4370004548778, 60658.0, 61220.693896530676, 61441.6927915362, 61676.38323616796, 61700.69149654268, 14770.187639679705, 14973.775393369107, 15003.474878379204, 15029.624259393384, 15218.923905380403, 23231.88384058069, 23451.296461106194, 23569.764302356758, 23620.40948976255, 23697.526049478915, 8401.747947561584, 8460.407771456063, 8621.69824056155, 8632.0, 8641.956790216134, 7105.218425973138, 7138.607971445622, 7281.781546553612, 7302.306280903305, 7332.743353982585, 7365.631718414058, 7433.962830185815, 7466.440016998638, 7540.245975402416, 7541.773746787605, 1797.4517772079641, 1817.918193681261, 1873.063468265867, 2936.853157342124, 3070.1096681962426, 909.88171537701, 933.8272419602396, 977.7360112769512, 985.3447457440722, 990.5790039233297, 15609.531714048597, 16365.509034728977, 16383.262753176135, 16550.006999580062, 16562.50312490603, 845.9703910363107, 873.5763154869883, 889.7731078574922, 928.5450129436528, 944.9669261575812, 8719.651213951498, 8753.781155471164, 8983.865242021375, 9011.234045106108, 9035.728928132166, 373268.0, 381540.0, 510497.0, 510681.0, 518308.0, 62664.68667656724, 64048.0, 69285.65357173182, 71386.0, 73977.0, 1142.5886680794906, 1159.4782347943628, 1165.7959857025157, 1175.435790820411, 1186.0, 14852.777208341668, 15021.098734075991, 15112.395504179709, 15181.6204594886, 15363.38546458174, 31595.526067109473, 32018.67981320157, 32496.512552312208, 32521.34957300888, 33533.0, 42429.7271081868, 42651.0, 42728.5727142737, 43302.350464743686, 43377.3493397593, 7161.140663120251, 7255.709771609077, 7298.416126709957, 7466.141393739789, 7516.173220945801, 10181.389116653025, 10360.792784144123, 10896.400697961371, 10970.835437468604, 11111.777764444827, 9040.0, 9041.954790226007, 9233.169014788702, 9273.907260927304, 9336.253099752139, 9535.284853636143, 9653.372530785477, 9681.080297371738, 9748.951255243679, 9864.950675246579, 8880.1563851434, 9356.988247526815, 9428.15146636806, 9547.188488978514, 9598.472084035166, 7207.171175314906, 7276.927230727837, 7327.4612331411, 7335.816604584715, 7399.482036257626, 3210.566573512546, 7921.93053937711, 8609.655613775629, 8717.433366831136, 9339.0], "unit": "score", "name": "jquery.html", "value": 8782.827782385528}, {"lowerIsBetter": false, "replicates": [1475.867171954524, 1503.5940296120045, 1674.0876222458758, 1757.7539144519762, 1795.3267524678245, 7379.52033117847, 7595.0, 7610.391168706504, 7768.378529717623, 7809.726659566923, 7746.53520788753, 7766.0, 7825.804354891131, 7851.2933835954755, 7851.960740196305, 2284.417473544248, 2296.6555016747457, 2328.39461739948, 2331.1025255276672, 2335.369450248432, 2380.595298799208, 2389.307100940734, 2390.916317928873, 2418.6251131074623, 2422.2854257993845, 2282.5549017941507, 2312.8612283262974, 2319.605667036608, 2355.281639100074, 2358.749862572839, 2338.356951838241, 2347.4131467133216, 2361.7047869016374, 2372.5017746273215, 2379.3218932604213, 2363.0902102690416, 2374.169040835711, 2387.7850993410675, 2394.8084153267873, 2395.8921848516857, 7732.149463559061, 7812.414068944795, 7813.374930005586, 7814.921850781477, 7830.256125668109, 4723.315119307681, 4804.975975120137, 4832.637552183601, 4835.395575553056, 4842.878928026792, 2974.107767669712, 3016.4871971764633, 3030.31817840984, 3048.2684155802667, 3092.0723782865275, 936.9365769851199, 951.728757304165, 969.4377261188494, 989.9703008909744, 991.8212130122938, 10570.630027948984, 10645.148388129008, 10706.571737130505, 10720.410377429238, 10728.141748660088, 4205.285101532747, 4215.0, 4278.379634952915, 4292.678049146327, 4388.780560972003, 8704.129587041245, 8738.0, 8740.388172827841, 8746.737597872074, 8798.164174403422, 4822.324874517571, 4843.0, 4876.390451193601, 4882.365292512021, 4888.046830868017, 4433.844815431509, 4445.244308467568, 4469.150861336336, 4482.21561226784, 4492.752898590609, 3556.02209392414, 3563.768355056913, 3586.1393265616066, 3601.1897323102094, 3602.85588576454, 1014.3558840136419, 1090.6019302954523, 1101.8732845722684, 1114.0363585498646, 1117.0728295514702, 972.5234635028785, 1016.7813920007234, 1059.9364038157735, 1064.5794911010107, 1216.2337727231964, 6805.047293378931, 6900.5859648420255, 6906.0, 6915.446764258847, 6931.4108300795, 619.4332186049804, 630.5554584018348, 633.7084940927133, 634.403660559073, 745.2473002267749, 5369.36234448497, 5385.380681221632, 5409.972950135224, 5411.648242864201, 5445.564354851603, 8783.648654053894, 8960.731178064669, 9175.58709858058, 9261.259099272042, 9280.814383712423, 9117.0, 9161.221296189766, 9162.496062716615, 9172.72481825533, 9219.0, 6872.828179295458, 7016.789496315118, 7088.645567721594, 7108.92891071093, 7223.494355395072, 6964.408025317702, 6999.615021173884, 7011.894821577578, 7018.368346848808, 7042.471814613822, 8167.754967350751, 8199.262066414052, 8305.543195124326, 8325.791855203668, 8382.203690649378, 8400.159984001551, 8609.0, 8624.353173511887, 8644.740657780276, 8660.35047371437, 6278.434940855345, 6606.47148228131, 6830.214525329452, 6845.110135682329, 6861.176658800976, 7208.0, 7216.675249613675, 7262.419006479575, 7283.526570772883, 7290.4896657233485, 5970.253718285215, 6631.801045968628, 6738.225104113089, 6813.4549236061985, 6993.0, 6724.361185687352, 6745.696443659949, 6799.830004249736, 6847.144106986627, 6884.621345826027, 6473.158489396348, 6595.241547221939, 6610.471162306908, 6623.205215374186, 6631.767888123893, 6403.679816009274, 6411.294757576569, 6454.257760357431, 6461.644609546332, 6476.870462590816, 6229.4393504584805, 6302.117703521602, 6309.558330916791, 6337.683115844097, 6383.042543618494], "unit": "score", "name": "mootools.html", "value": 4373.915652156536}, {"lowerIsBetter": false, "replicates": [350.7281856561165, 353.8832185378825, 354.96095429502765, 356.04224635729884, 357.57627211754067, 6116.0, 6116.113163591277, 6175.980963141082, 6234.002559590466, 6248.593841400311, 6118.174046503721, 6206.441420272175, 6244.812655620327, 6247.062940558919, 6264.812055638338, 4760.690555113923, 4793.496682848303, 4806.447258565275, 4807.399075115611, 4819.638527110455, 4806.3030860525205, 4820.662553621248, 4840.757962101899, 4853.296272040552, 4855.757212139397, 4710.693804902688, 4802.23164293713, 4806.231003039515, 4816.686915350509, 4817.012512434942, 4793.233082706767, 4795.256735206014, 4800.759962001904, 4812.687175333627, 4822.6624136310475, 4199.160167966419, 4229.36559516072, 4246.7876606169875, 4248.490181178278, 4253.936190957138, 5898.646081235097, 5917.08285215788, 5921.052631578969, 5930.110483427477, 5934.13954976526, 5483.561315094783, 5517.972410137923, 5551.611387202897, 5574.358948720908, 5589.0, 6532.510061745341, 6567.113439685629, 6572.047053177263, 6585.604863708145, 6632.8673426531195, 4664.043871006469, 4665.740250132445, 4666.743329116897, 4669.439667239919, 4675.719456832567, 6691.096701945273, 6918.93081069193, 6927.826804329881, 6928.61892595907, 6966.582005079711, 4681.274402467623, 4695.671303008825, 4701.459332176775, 4701.717896926195, 4715.693479923794, 4763.499832517605, 4764.4520880098535, 4766.594839438687, 4771.141194584939, 4772.403449568804, 5510.752016159283, 5541.889162216733, 5563.248961390242, 5567.582431317586, 5580.1629755537, 6549.083128362033, 6690.397864192246, 6717.764878229336, 6760.966195169091, 6813.1142951415995, 1655.6854197702398, 1711.1700825099817, 1714.0829656133908, 1718.7937447506379, 1729.1267909705518, 1165.7726743285148, 1175.8824117588345, 1177.9705507362385, 1184.922980006297, 1185.3362117214388, 6156.661383623944, 6161.691915404212, 6163.137160797492, 6167.136600875881, 6189.876202476015, 6624.86750264992, 6643.2360278568585, 6658.800235992928, 6681.599104053772, 6721.4958878084335, 6021.187139736079, 6165.537584681167, 6169.290531588925, 6173.41352571505, 6177.598456100339, 3655.287218992324, 3655.3054919565197, 3668.8899333019517, 3669.5596528416227, 3672.8714494992546, 7044.330788575077, 7092.113485814273, 7128.144622645315, 7129.572225666477, 7137.92862071383, 6752.257251702309, 6904.171499420102, 6924.099867017256, 6929.411000065051, 6965.547239429421, 7084.716611335592, 7102.254263302382, 7107.111611048619, 7112.715491380287, 7120.1099862517185, 6697.3637504437, 6707.698153583003, 6711.697973591297, 6741.966290168518, 6767.526273160832, 6534.215894092739, 6642.236142843635, 6673.1992160941, 6675.7997260082275, 6688.6990085445295, 7109.4667899908745, 7121.572705637678, 7135.322144396274, 7136.7145314186855, 7145.21402645719, 4695.4834968154155, 4709.0346478972415, 4714.976425117852, 4723.551262630044, 4733.644976626836, 6690.732370705117, 6778.32216778338, 6780.084688566981, 6786.3892249697765, 7001.404880585003, 6690.163729533809, 6691.866162676816, 6711.463082953254, 6739.0902228198565, 6764.5603035802515, 6646.90029649546, 6692.732290708317, 6693.330666933462, 6695.363940425652, 6708.26209116987, 6460.321666224979, 6593.109930159559, 6619.4373478252965, 6634.336566343327, 6635.2037755469655, 6639.601623902581, 6666.866662666623, 6726.596404215763, 6747.527673063035, 6786.796396108125, 6565.606063636006, 6586.868262634816, 6589.17635295588, 6600.933990660032, 6617.735290588323], "unit": "score", "name": "prototype.html", "value": 5008.843065263899}, {"lowerIsBetter": false, "replicates": [749.3106342165211, 772.7488566215981, 788.996055019725, 802.2218448105338, 832.6003518311211, 12894.226346419222, 13158.671033224175, 13161.802572961402, 13166.868331316684, 13194.53819116331, 11573.074154067675, 12478.81281780774, 12545.68635784106, 12822.166559173671, 12828.230306181613, 787.1970589998199, 792.6353877216487, 798.2217338095369, 799.1928152565921, 803.1767438375682, 797.3421926910294, 799.7121036426881, 801.4590151647615, 807.1726480357622, 811.0834756724922, 843.1989609870617, 846.5894041389921, 849.3120572336427, 849.723839752083, 851.4635779458932, 839.9118092600311, 840.5923127283263, 840.7099550655014, 846.238385453091, 847.8728190771403, 618.3352895637208, 619.2630769384418, 619.4332186049759, 621.4251817069193, 622.5331001748689, 11275.943620281847, 11337.206395552315, 11385.146114041398, 11392.430378481044, 11457.484413201426, 11116.888831111666, 11255.155863310285, 11294.717632059183, 11386.487608057658, 11659.300441973508, 8343.16568343167, 8382.958085209595, 8580.013298470692, 8715.389922705413, 8733.7816554586, 3496.4230901901155, 3527.7883327000204, 3542.574891013069, 3635.000374896898, 3641.6904563112166, 44413.77793111046, 44875.55124448746, 46610.0, 49712.0, 49788.0, 10258.58965641366, 10336.328138670962, 10500.0, 10538.525766340534, 10731.83902241467, 18652.906735466237, 18823.623527529373, 18834.0, 18874.056297185085, 18943.0, 7519.586422746692, 7520.247975202436, 7570.962145189349, 7627.351675107567, 7736.226377362219, 3904.96095039046, 3975.4235635832642, 4053.493313335833, 4071.4096456014304, 4089.284375234322, 2971.9108426747234, 2974.2415684000443, 2982.0904624089862, 2990.7756918230784, 2995.550667399864, 555.5694336888944, 567.5799908068, 574.1789241384777, 578.9189513468118, 580.5471732049009, 480.75000999480073, 522.3548917087394, 571.8513186571521, 578.1068249554448, 666.7166454256921, 7863.9213607863185, 8181.18188181189, 8262.132476090044, 8364.707235246737, 8397.28623067034, 565.6125553995527, 611.1993288791697, 661.9966900165468, 689.7654797368918, 698.7309885694044, 4073.877783666495, 4104.753714777064, 4110.609492098246, 4138.6482149017065, 4193.098483825931, 55931.0, 56242.71878640662, 56369.43630563642, 57003.42996570064, 57428.425715742305, 49799.75100124476, 50688.0, 51077.0, 51209.48790512122, 51427.485725143015, 39666.0, 45882.85292867705, 50402.49597504051, 51015.489845101074, 51887.74056129695, 8875.0, 8937.73186804397, 8970.686025989058, 9240.311616136609, 9251.491167985825, 33563.0, 33810.3237935235, 34135.829320853234, 34405.311893761485, 34890.82554587211, 42375.57624423716, 42962.78518607387, 43013.13973720445, 43939.56060439483, 43978.56021439873, 10219.7445063874, 10234.283600148216, 10360.378377297386, 10487.79024419492, 11298.548058077586, 10621.15030797519, 10643.308184967953, 10662.413567253876, 10673.786524269626, 11225.494852731483, 11362.772744544898, 11441.599544015919, 11533.711657208636, 11855.703607409883, 12075.456604452645, 10802.783944320912, 11010.779784404427, 11152.16358773079, 11309.321440713584, 11363.715907102058, 11306.660800176009, 11306.660800176009, 11385.0, 11512.59705910289, 11901.940490297493, 9413.858792117986, 9688.46713430768, 10026.899731002597, 10040.196784257096, 10199.337043092175, 9495.28785341116, 9560.904390956, 9644.276679248944, 9675.70972870815, 9827.557759900965], "unit": "score", "name": "yui.html", "value": 6152.958321008654}], "name": "dromaeo_css", "value": 6894.489006241585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 112.0, 113.0, 115.0, 123.0, 113.0, 110.0, 111.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 162.0, 170.0, 135.0, 161.0, 155.0, 138.0, 164.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 163.0, 161.0, 161.0, 162.0, 166.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 73.0, 76.0, 135.0, 73.0, 75.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 97.0, 96.0, 96.0, 139.0, 97.0, 99.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 149.0, 146.0, 147.0, 146.0, 148.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 97.0, 97.0, 99.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 65.0, 62.0, 60.0, 61.0, 62.0, 59.0, 61.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 61.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 91.0, 83.0, 84.0, 85.0, 84.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [113.0, 126.0, 122.0, 128.0, 119.0, 118.0, 129.0, 122.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 156.0, 141.0, 143.0, 141.0, 144.0, 144.0, 144.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 69.0, 67.0, 66.0, 68.0, 67.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1516.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [190.91256204658268], "unit": "score", "name": "DeltaBlue", "value": 346.3260840000001}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [744.047619047619], "unit": "score", "name": "Earley", "value": 895.7262720000001}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [41428.57142857143], "unit": "score", "name": "RegExp", "value": 21.989293103448276}, {"lowerIsBetter": false, "replicates": [610.5006105006105], "unit": "score", "name": "Splay", "value": 133.48225799999997}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 20177.28444794769}]} 11:06:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20177.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6894.49"}}} 11:06:46 INFO - Return code: 0 11:06:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:06:46 INFO - # TBPL SUCCESS # 11:06:46 INFO - Running post-action listener: _resource_record_post_action 11:06:46 INFO - Running post-run listener: _resource_record_post_run 11:06:47 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 555876352; Read time: 0; Write time: 651344 11:06:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243593216; Read time: 0; Write time: 333988 11:06:47 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 312283136; Read time: 0; Write time: 317356 11:06:47 INFO - Running post-run listener: _upload_blobber_files 11:06:47 INFO - Blob upload gear active. 11:06:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:06:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:06:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:06:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:06:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:49 INFO - (blobuploader) - INFO - Done attempting. 11:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:49 INFO - (blobuploader) - INFO - Done attempting. 11:06:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:06:49 INFO - Return code: 0 11:06:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:06:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:06:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286f526b52b846fa2a34f4f46a102c2a2b504e14fabc563cfcd09e8465f78a4b24ce83350fe8a6789fe836bd4d9d1243781749bf38dd7e9fe2a8f8c2623354fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faa61b01e40b5281b41f597fa30604dad1c2021a0b6545c2457f3639679ecca9982bbf6f3df2f155ca1576e6d25f5187b647136b96851e1a435bf97ccefb881e"} 11:06:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:06:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:06:49 INFO - Contents: 11:06:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286f526b52b846fa2a34f4f46a102c2a2b504e14fabc563cfcd09e8465f78a4b24ce83350fe8a6789fe836bd4d9d1243781749bf38dd7e9fe2a8f8c2623354fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faa61b01e40b5281b41f597fa30604dad1c2021a0b6545c2457f3639679ecca9982bbf6f3df2f155ca1576e6d25f5187b647136b96851e1a435bf97ccefb881e"} 11:06:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:06:49 INFO - Copying logs to upload dir... 11:06:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:06:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.529148 ========= master_lag: 26.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-22 11:07:15.613454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 11:07:15.616722) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286f526b52b846fa2a34f4f46a102c2a2b504e14fabc563cfcd09e8465f78a4b24ce83350fe8a6789fe836bd4d9d1243781749bf38dd7e9fe2a8f8c2623354fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faa61b01e40b5281b41f597fa30604dad1c2021a0b6545c2457f3639679ecca9982bbf6f3df2f155ca1576e6d25f5187b647136b96851e1a435bf97ccefb881e"} build_url:https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/286f526b52b846fa2a34f4f46a102c2a2b504e14fabc563cfcd09e8465f78a4b24ce83350fe8a6789fe836bd4d9d1243781749bf38dd7e9fe2a8f8c2623354fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/faa61b01e40b5281b41f597fa30604dad1c2021a0b6545c2457f3639679ecca9982bbf6f3df2f155ca1576e6d25f5187b647136b96851e1a435bf97ccefb881e"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 11:07:15.810946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 11:07:15.811321) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1453488341.524425-1661648137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 11:07:15.827895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 11:07:15.828298) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 11:07:15.828620) ========= ========= Total master_lag: 26.54 =========