builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1453449195.93 results: success (0) buildid: 20160121193151 builduid: 2e468cec3e304059a35b4aa6edaa03f4 revision: c5da92c5b4906369dee83629f81d647226ac1038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:15.931128) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:15.931665) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:15.932059) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006346 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:15.966986) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:15.967359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.012781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.013153) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.064893) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.065217) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.065604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.066561) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 23:53:16-- 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% 38.0M=0s 2016-01-21 23:53:16 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.188423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.188976) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022397 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.240312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.240841) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5da92c5b4906369dee83629f81d647226ac1038 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c5da92c5b4906369dee83629f81d647226ac1038 --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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 23:53:16,841 truncating revision to first 12 chars 2016-01-21 23:53:16,841 Setting DEBUG logging. 2016-01-21 23:53:16,841 attempt 1/10 2016-01-21 23:53:16,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5da92c5b490?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 23:53:17,098 unpacking tar archive at: mozilla-central-c5da92c5b490/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530166 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.784467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.784829) ========= echo c5da92c5b4906369dee83629f81d647226ac1038 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c5da92c5b4906369dee83629f81d647226ac1038'] 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c5da92c5b4906369dee83629f81d647226ac1038 program finished with exit code 0 elapsedTime=0.003702 script_repo_revision: 'c5da92c5b4906369dee83629f81d647226ac1038' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.833910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.834289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 23:53:16.847212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-21 23:53:16.847542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:53:17 INFO - MultiFileLogger online at 20160121 23:53:17 in /builds/slave/test-pgo 23:53:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:53:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:53:17 INFO - {'append_to_log': False, 23:53:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:53:17 INFO - 'blob_upload_branch': 'Firefox', 23:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:53:17 INFO - 'branch': 'Firefox', 23:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 23:53:17 INFO - 'config_files': ('talos/linux_config.py',), 23:53:17 INFO - 'default_actions': ('clobber', 23:53:17 INFO - 'read-buildbot-config', 23:53:17 INFO - 'download-and-extract', 23:53:17 INFO - 'populate-webroot', 23:53:17 INFO - 'create-virtualenv', 23:53:17 INFO - 'install', 23:53:17 INFO - 'run-tests'), 23:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:53:17 INFO - 'download_minidump_stackwalk': True, 23:53:17 INFO - 'download_symbols': 'ondemand', 23:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 23:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 23:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:53:17 INFO - 'installer_path': 'installer.exe', 23:53:17 INFO - 'log_level': 'info', 23:53:17 INFO - 'log_name': 'talos', 23:53:17 INFO - 'log_to_console': True, 23:53:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:53:17 INFO - 'opt_config_files': (), 23:53:17 INFO - 'pip_index': False, 23:53:17 INFO - 'sps_profile': False, 23:53:17 INFO - 'sps_profile_interval': 0, 23:53:17 INFO - 'suite': 'dromaeojs-e10s', 23:53:17 INFO - 'system_bits': '32', 23:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:53:17 INFO - 'title': 'talos-linux64-ix-034', 23:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:53:17 INFO - 'use_talos_json': True, 23:53:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:53:17 INFO - 'work_dir': 'build'} 23:53:17 INFO - ##### 23:53:17 INFO - ##### Running clobber step. 23:53:17 INFO - ##### 23:53:17 INFO - Running pre-action listener: _resource_record_pre_action 23:53:17 INFO - Running main action method: clobber 23:53:17 INFO - rmtree: /builds/slave/test-pgo/build 23:53:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:53:18 INFO - Running post-action listener: _resource_record_post_action 23:53:18 INFO - ##### 23:53:18 INFO - ##### Running read-buildbot-config step. 23:53:18 INFO - ##### 23:53:18 INFO - Running pre-action listener: _resource_record_pre_action 23:53:18 INFO - Running main action method: read_buildbot_config 23:53:18 INFO - Using buildbot properties: 23:53:18 INFO - { 23:53:18 INFO - "project": "", 23:53:18 INFO - "product": "firefox", 23:53:18 INFO - "script_repo_revision": "production", 23:53:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:53:18 INFO - "repository": "", 23:53:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 23:53:18 INFO - "buildid": "20160121193151", 23:53:18 INFO - "pgo_build": "True", 23:53:18 INFO - "basedir": "/builds/slave/test-pgo", 23:53:18 INFO - "buildnumber": 81, 23:53:18 INFO - "slavename": "talos-linux64-ix-034", 23:53:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:53:18 INFO - "platform": "ubuntu64_hw", 23:53:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 23:53:18 INFO - "branch": "mozilla-central", 23:53:18 INFO - "repo_path": "mozilla-central", 23:53:18 INFO - "revision": "c5da92c5b4906369dee83629f81d647226ac1038", 23:53:18 INFO - "stage_platform": "linux64-pgo", 23:53:18 INFO - "builduid": "2e468cec3e304059a35b4aa6edaa03f4", 23:53:18 INFO - "slavebuilddir": "test" 23:53:18 INFO - } 23:53:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:53:18 INFO - Running post-action listener: _resource_record_post_action 23:53:18 INFO - ##### 23:53:18 INFO - ##### Running download-and-extract step. 23:53:18 INFO - ##### 23:53:18 INFO - Running pre-action listener: _resource_record_pre_action 23:53:18 INFO - Running main action method: download_and_extract 23:53:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:18 INFO - https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/test_packages.json 23:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/test_packages.json 23:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:53:27 INFO - Downloaded 1448 bytes. 23:53:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:53:27 INFO - Using the following test package requirements: 23:53:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:53:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:53:27 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:53:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'jsshell-linux-x86_64.zip'], 23:53:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:53:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:53:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:53:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:53:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:53:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:53:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:53:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:53:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:53:27 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')]} 23:53:27 INFO - https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:32 INFO - Downloaded 22486967 bytes. 23:53:32 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'] 23:53:32 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 23:53:33 INFO - Return code: 0 23:53:33 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 23:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:33 INFO - https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:53:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:53:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:53:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:34 INFO - Downloaded 22486967 bytes. 23:53:34 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'] 23:53:34 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 23:53:35 INFO - Return code: 0 23:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:35 INFO - https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:36 INFO - Downloaded 10706572 bytes. 23:53:36 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'] 23:53:36 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 23:53:36 INFO - Return code: 0 23:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:36 INFO - https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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 23:53:38 INFO - Downloaded 55975085 bytes. 23:53:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:53:38 INFO - mkdir: /builds/slave/test-pgo/properties 23:53:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:53:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:53:38 INFO - Contents: 23:53:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:53:38 INFO - Running post-action listener: _resource_record_post_action 23:53:38 INFO - Running post-action listener: set_extra_try_arguments 23:53:38 INFO - ##### 23:53:38 INFO - ##### Running populate-webroot step. 23:53:38 INFO - ##### 23:53:38 INFO - Running pre-action listener: _resource_record_pre_action 23:53:38 INFO - Running main action method: populate_webroot 23:53:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:53:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:53:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:53:38 INFO - '--tppagecycles', 23:53:38 INFO - '7'], 23:53:38 INFO - 'tests': ['tsvgm']}}, 23:53:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:53:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:53:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:53:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:53:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:53:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:53:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'tests': ['damp', 'tps']}, 23:53:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['damp', 'tps']}, 23:53:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:53:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:53:38 INFO - 'other': {'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'other_l64': {'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'other_nol64': {'tests': ['a11yr', 23:53:38 INFO - 'ts_paint', 23:53:38 INFO - 'tpaint', 23:53:38 INFO - 'sessionrestore', 23:53:38 INFO - 'sessionrestore_no_auto_restore']}, 23:53:38 INFO - 'svgr': {'tests': ['tsvgx', 23:53:38 INFO - 'tsvgr_opacity', 23:53:38 INFO - 'tart', 23:53:38 INFO - 'tscrollx', 23:53:38 INFO - 'cart']}, 23:53:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['tsvgx', 23:53:38 INFO - 'tsvgr_opacity', 23:53:38 INFO - 'tart', 23:53:38 INFO - 'tscrollx', 23:53:38 INFO - 'cart']}, 23:53:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'tests': ['tp5o']}, 23:53:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'talos_options': ['--e10s'], 23:53:38 INFO - 'tests': ['tp5o']}, 23:53:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'talos_options': ['--xperf_path', 23:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:53:38 INFO - 'tests': ['tp5n']}, 23:53:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:53:38 INFO - 'talos_options': ['--e10s', 23:53:38 INFO - '--xperf_path', 23:53:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:53:38 INFO - 'tests': ['tp5n']}}, 23:53:38 INFO - 'talos.zip': {'path': '', 23:53:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:53:38 INFO - Running post-action listener: _resource_record_post_action 23:53:38 INFO - ##### 23:53:38 INFO - ##### Running create-virtualenv step. 23:53:38 INFO - ##### 23:53:38 INFO - Running pre-action listener: _resource_record_pre_action 23:53:38 INFO - Running main action method: create_virtualenv 23:53:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:53:38 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 23:53:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:53:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:53:38 INFO - Using real prefix '/usr' 23:53:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 23:53:40 INFO - Installing pip.................done. 23:53:40 INFO - Return code: 0 23:53:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:40 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:40 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 23:53:40 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 23:53:40 INFO - Using env: {'DISPLAY': ':0', 23:53:40 INFO - 'HOME': '/home/cltbld', 23:53:40 INFO - 'LANG': 'en_US.UTF-8', 23:53:40 INFO - 'LANGUAGE': 'en_US:en', 23:53:40 INFO - 'LOGNAME': 'cltbld', 23:53:40 INFO - 'MAIL': '/var/mail/cltbld', 23:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:40 INFO - 'MOZ_NO_REMOTE': '1', 23:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:40 INFO - 'NO_EM_RESTART': '1', 23:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:40 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:40 INFO - 'SHELL': '/bin/bash', 23:53:40 INFO - 'SHLVL': '1', 23:53:40 INFO - 'TERM': 'linux', 23:53:40 INFO - 'TMOUT': '86400', 23:53:40 INFO - 'USER': 'cltbld', 23:53:40 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:40 INFO - '_': '/tools/buildbot/bin/python'} 23:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:41 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 23:53:41 INFO - Cleaning up... 23:53:41 INFO - Return code: 0 23:53:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:41 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:41 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 23:53:41 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 23:53:41 INFO - Using env: {'DISPLAY': ':0', 23:53:41 INFO - 'HOME': '/home/cltbld', 23:53:41 INFO - 'LANG': 'en_US.UTF-8', 23:53:41 INFO - 'LANGUAGE': 'en_US:en', 23:53:41 INFO - 'LOGNAME': 'cltbld', 23:53:41 INFO - 'MAIL': '/var/mail/cltbld', 23:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:41 INFO - 'MOZ_NO_REMOTE': '1', 23:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:41 INFO - 'NO_EM_RESTART': '1', 23:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:41 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:41 INFO - 'SHELL': '/bin/bash', 23:53:41 INFO - 'SHLVL': '1', 23:53:41 INFO - 'TERM': 'linux', 23:53:41 INFO - 'TMOUT': '86400', 23:53:41 INFO - 'USER': 'cltbld', 23:53:41 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:41 INFO - '_': '/tools/buildbot/bin/python'} 23:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:41 INFO - Downloading/unpacking psutil>=0.7.1 23:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:53:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:53:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:53:43 INFO - Installing collected packages: psutil 23:53:43 INFO - Running setup.py install for psutil 23:53:43 INFO - building 'psutil._psutil_linux' extension 23:53:43 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 23:53:43 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 23:53:43 INFO - building 'psutil._psutil_posix' extension 23:53:43 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 23:53:43 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 23:53:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:53:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:53:43 INFO - Successfully installed psutil 23:53:43 INFO - Cleaning up... 23:53:43 INFO - Return code: 0 23:53:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:43 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:43 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 23:53:43 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 23:53:43 INFO - Using env: {'DISPLAY': ':0', 23:53:43 INFO - 'HOME': '/home/cltbld', 23:53:43 INFO - 'LANG': 'en_US.UTF-8', 23:53:43 INFO - 'LANGUAGE': 'en_US:en', 23:53:43 INFO - 'LOGNAME': 'cltbld', 23:53:43 INFO - 'MAIL': '/var/mail/cltbld', 23:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:43 INFO - 'MOZ_NO_REMOTE': '1', 23:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:43 INFO - 'NO_EM_RESTART': '1', 23:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:43 INFO - 'SHELL': '/bin/bash', 23:53:43 INFO - 'SHLVL': '1', 23:53:43 INFO - 'TERM': 'linux', 23:53:43 INFO - 'TMOUT': '86400', 23:53:43 INFO - 'USER': 'cltbld', 23:53:43 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:43 INFO - '_': '/tools/buildbot/bin/python'} 23:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:53:45 INFO - Installing collected packages: mozsystemmonitor 23:53:45 INFO - Running setup.py install for mozsystemmonitor 23:53:45 INFO - Successfully installed mozsystemmonitor 23:53:45 INFO - Cleaning up... 23:53:45 INFO - Return code: 0 23:53:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:53: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')]} 23:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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')]} 23:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:45 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:45 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 23:53:45 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 23:53:45 INFO - Using env: {'DISPLAY': ':0', 23:53:45 INFO - 'HOME': '/home/cltbld', 23:53:45 INFO - 'LANG': 'en_US.UTF-8', 23:53:45 INFO - 'LANGUAGE': 'en_US:en', 23:53:45 INFO - 'LOGNAME': 'cltbld', 23:53:45 INFO - 'MAIL': '/var/mail/cltbld', 23:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:45 INFO - 'MOZ_NO_REMOTE': '1', 23:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:45 INFO - 'NO_EM_RESTART': '1', 23:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:45 INFO - 'SHELL': '/bin/bash', 23:53:45 INFO - 'SHLVL': '1', 23:53:45 INFO - 'TERM': 'linux', 23:53:45 INFO - 'TMOUT': '86400', 23:53:45 INFO - 'USER': 'cltbld', 23:53:45 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:45 INFO - '_': '/tools/buildbot/bin/python'} 23:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:53:46 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 23:53:46 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 23:53:46 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 23:53:46 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 23:53:46 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 23:53:46 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 23:53:47 INFO - Downloading blobuploader-1.2.4.tar.gz 23:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:53:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:53:47 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 23:53:47 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 23:53:47 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 23:53:47 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 23:53:47 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 23:53:47 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 23:53:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:53:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:48 INFO - Downloading docopt-0.6.1.tar.gz 23:53:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:53:48 INFO - Installing collected packages: blobuploader, requests, docopt 23:53:48 INFO - Running setup.py install for blobuploader 23:53:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:53:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:53:48 INFO - Running setup.py install for requests 23:53:48 INFO - Running setup.py install for docopt 23:53:49 INFO - Successfully installed blobuploader requests docopt 23:53:49 INFO - Cleaning up... 23:53:49 INFO - Return code: 0 23:53:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:49 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:49 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 23:53:49 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 23:53:49 INFO - Using env: {'DISPLAY': ':0', 23:53:49 INFO - 'HOME': '/home/cltbld', 23:53:49 INFO - 'LANG': 'en_US.UTF-8', 23:53:49 INFO - 'LANGUAGE': 'en_US:en', 23:53:49 INFO - 'LOGNAME': 'cltbld', 23:53:49 INFO - 'MAIL': '/var/mail/cltbld', 23:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:49 INFO - 'MOZ_NO_REMOTE': '1', 23:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:49 INFO - 'NO_EM_RESTART': '1', 23:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:49 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:49 INFO - 'SHELL': '/bin/bash', 23:53:49 INFO - 'SHLVL': '1', 23:53:49 INFO - 'TERM': 'linux', 23:53:49 INFO - 'TMOUT': '86400', 23:53:49 INFO - 'USER': 'cltbld', 23:53:49 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:49 INFO - '_': '/tools/buildbot/bin/python'} 23:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:53:49 INFO - Running setup.py (path:/tmp/pip-xARN2R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:53:49 INFO - Running setup.py (path:/tmp/pip-Jz0LSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:53:49 INFO - Running setup.py (path:/tmp/pip-lUJASE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:53:49 INFO - Running setup.py (path:/tmp/pip-REgc3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:53:49 INFO - Running setup.py (path:/tmp/pip-OnfItV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:53:49 INFO - Running setup.py (path:/tmp/pip-jMYbq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:53:49 INFO - Running setup.py (path:/tmp/pip-exVJVZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:53:49 INFO - Running setup.py (path:/tmp/pip-9ntk6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:53:49 INFO - Running setup.py (path:/tmp/pip-oG3SPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:53:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:53:49 INFO - Running setup.py (path:/tmp/pip-dOli8I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:53:50 INFO - Running setup.py (path:/tmp/pip-k5DvKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:53:50 INFO - Running setup.py (path:/tmp/pip-XAV4AE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:53:50 INFO - Running setup.py (path:/tmp/pip-t6k7in-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:53:50 INFO - Running setup.py (path:/tmp/pip-XIe_hb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:50 INFO - Running setup.py (path:/tmp/pip-oaN066-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:50 INFO - Running setup.py (path:/tmp/pip-POIegz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:50 INFO - Running setup.py (path:/tmp/pip-z3Ec2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:53:50 INFO - Running setup.py install for manifestparser 23:53:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:53:50 INFO - Running setup.py install for mozcrash 23:53:50 INFO - Running setup.py install for mozdebug 23:53:50 INFO - Running setup.py install for mozdevice 23:53:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:53:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozfile 23:53:51 INFO - Running setup.py install for mozhttpd 23:53:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozinfo 23:53:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozInstall 23:53:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozleak 23:53:51 INFO - Running setup.py install for mozlog 23:53:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for moznetwork 23:53:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozprocess 23:53:51 INFO - Running setup.py install for mozprofile 23:53:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:53:51 INFO - Running setup.py install for mozrunner 23:53:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:53:52 INFO - Running setup.py install for mozscreenshot 23:53:52 INFO - Running setup.py install for moztest 23:53:52 INFO - Running setup.py install for mozversion 23:53:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:53:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:53:52 INFO - Cleaning up... 23:53:52 INFO - Return code: 0 23:53:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:53:52 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')]} 23:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:52 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')]} 23:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:52 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:52 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 23:53:52 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 23:53:52 INFO - Using env: {'DISPLAY': ':0', 23:53:52 INFO - 'HOME': '/home/cltbld', 23:53:52 INFO - 'LANG': 'en_US.UTF-8', 23:53:52 INFO - 'LANGUAGE': 'en_US:en', 23:53:52 INFO - 'LOGNAME': 'cltbld', 23:53:52 INFO - 'MAIL': '/var/mail/cltbld', 23:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:52 INFO - 'MOZ_NO_REMOTE': '1', 23:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:52 INFO - 'NO_EM_RESTART': '1', 23:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:52 INFO - 'SHELL': '/bin/bash', 23:53:52 INFO - 'SHLVL': '1', 23:53:52 INFO - 'TERM': 'linux', 23:53:52 INFO - 'TMOUT': '86400', 23:53:52 INFO - 'USER': 'cltbld', 23:53:52 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:52 INFO - '_': '/tools/buildbot/bin/python'} 23:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:53:52 INFO - Running setup.py (path:/tmp/pip-f6vryH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:53:52 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)) 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:53:52 INFO - Running setup.py (path:/tmp/pip-lVriXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:53:52 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)) 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:53:52 INFO - Running setup.py (path:/tmp/pip-ySZEsy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:53:52 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)) 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:53:52 INFO - Running setup.py (path:/tmp/pip-xbwwmX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:53:52 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)) 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:53:52 INFO - Running setup.py (path:/tmp/pip-dn87eC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:53:52 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)) 23:53:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:53:52 INFO - Running setup.py (path:/tmp/pip-PpQvQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:53:53 INFO - Running setup.py (path:/tmp/pip-Bck3iS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:53:53 INFO - Running setup.py (path:/tmp/pip-TGfAVl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:53:53 INFO - Running setup.py (path:/tmp/pip-cEtUAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:53:53 INFO - Running setup.py (path:/tmp/pip-aO84dL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:53:53 INFO - Running setup.py (path:/tmp/pip-WJgzDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:53:53 INFO - Running setup.py (path:/tmp/pip-c1NvW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:53:53 INFO - Running setup.py (path:/tmp/pip-VaynH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:53:53 INFO - Running setup.py (path:/tmp/pip-6W4pyB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:53 INFO - Running setup.py (path:/tmp/pip-06X3dA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:53 INFO - Running setup.py (path:/tmp/pip-ZMMwK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:53:53 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)) 23:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:53 INFO - Running setup.py (path:/tmp/pip-c9Gnas-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:53:53 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)) 23:53:53 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)) 23:53:53 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)) 23:53:53 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)) 23:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 23:53:53 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)) 23:53:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:53:55 INFO - Downloading blessings-1.6.tar.gz 23:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:53:55 INFO - Installing collected packages: blessings 23:53:55 INFO - Running setup.py install for blessings 23:53:55 INFO - Successfully installed blessings 23:53:55 INFO - Cleaning up... 23:53:55 INFO - Return code: 0 23:53:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:53:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:53:56 INFO - Reading from file tmpfile_stdout 23:53:56 INFO - Current package versions: 23:53:56 INFO - argparse == 1.2.1 23:53:56 INFO - blessings == 1.6 23:53:56 INFO - blobuploader == 1.2.4 23:53:56 INFO - docopt == 0.6.1 23:53:56 INFO - manifestparser == 1.1 23:53:56 INFO - mozInstall == 1.12 23:53:56 INFO - mozcrash == 0.16 23:53:56 INFO - mozdebug == 0.1 23:53:56 INFO - mozdevice == 0.48 23:53:56 INFO - mozfile == 1.2 23:53:56 INFO - mozhttpd == 0.7 23:53:56 INFO - mozinfo == 0.9 23:53:56 INFO - mozleak == 0.1 23:53:56 INFO - mozlog == 3.1 23:53:56 INFO - moznetwork == 0.27 23:53:56 INFO - mozprocess == 0.22 23:53:56 INFO - mozprofile == 0.28 23:53:56 INFO - mozrunner == 6.11 23:53:56 INFO - mozscreenshot == 0.1 23:53:56 INFO - mozsystemmonitor == 0.0 23:53:56 INFO - moztest == 0.7 23:53:56 INFO - mozversion == 1.4 23:53:56 INFO - psutil == 3.1.1 23:53:56 INFO - requests == 1.2.3 23:53:56 INFO - wsgiref == 0.1.2 23:53:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:56 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:56 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 23:53:56 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 23:53:56 INFO - Using env: {'DISPLAY': ':0', 23:53:56 INFO - 'HOME': '/home/cltbld', 23:53:56 INFO - 'LANG': 'en_US.UTF-8', 23:53:56 INFO - 'LANGUAGE': 'en_US:en', 23:53:56 INFO - 'LOGNAME': 'cltbld', 23:53:56 INFO - 'MAIL': '/var/mail/cltbld', 23:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:56 INFO - 'MOZ_NO_REMOTE': '1', 23:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:56 INFO - 'NO_EM_RESTART': '1', 23:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:56 INFO - 'SHELL': '/bin/bash', 23:53:56 INFO - 'SHLVL': '1', 23:53:56 INFO - 'TERM': 'linux', 23:53:56 INFO - 'TMOUT': '86400', 23:53:56 INFO - 'USER': 'cltbld', 23:53:56 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:56 INFO - '_': '/tools/buildbot/bin/python'} 23:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 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)) 23:53:56 INFO - Cleaning up... 23:53:56 INFO - Return code: 0 23:53:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53:56 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 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53:56 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 23:53:56 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 23:53:56 INFO - Using env: {'DISPLAY': ':0', 23:53:56 INFO - 'HOME': '/home/cltbld', 23:53:56 INFO - 'LANG': 'en_US.UTF-8', 23:53:56 INFO - 'LANGUAGE': 'en_US:en', 23:53:56 INFO - 'LOGNAME': 'cltbld', 23:53:56 INFO - 'MAIL': '/var/mail/cltbld', 23:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:56 INFO - 'MOZ_NO_REMOTE': '1', 23:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:56 INFO - 'NO_EM_RESTART': '1', 23:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:56 INFO - 'SHELL': '/bin/bash', 23:53:56 INFO - 'SHLVL': '1', 23:53:56 INFO - 'TERM': 'linux', 23:53:56 INFO - 'TMOUT': '86400', 23:53:56 INFO - 'USER': 'cltbld', 23:53:56 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:56 INFO - '_': '/tools/buildbot/bin/python'} 23:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:56 INFO - Downloading/unpacking jsonschema 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:53:58 INFO - Downloading/unpacking functools32 (from jsonschema) 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:53:58 INFO - warning: no files found matching '*.txt' 23:53:58 INFO - no previously-included directories found matching 'build' 23:53:58 INFO - no previously-included directories found matching 'dist' 23:53:58 INFO - no previously-included directories found matching '.git*' 23:53:58 INFO - Installing collected packages: jsonschema, functools32 23:53:58 INFO - Running setup.py install for functools32 23:53:58 INFO - warning: no files found matching '*.txt' 23:53:58 INFO - no previously-included directories found matching 'build' 23:53:58 INFO - no previously-included directories found matching 'dist' 23:53:58 INFO - no previously-included directories found matching '.git*' 23:53:58 INFO - Successfully installed jsonschema functools32 23:53:58 INFO - Cleaning up... 23:53:58 INFO - Return code: 0 23:53:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:53: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')]} 23:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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')]} 23:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f266e834f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26d3850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, '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': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', '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 23:53: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', 'flake8'] in /builds/slave/test-pgo/build 23:53: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 flake8 23:53:58 INFO - Using env: {'DISPLAY': ':0', 23:53:58 INFO - 'HOME': '/home/cltbld', 23:53:58 INFO - 'LANG': 'en_US.UTF-8', 23:53:58 INFO - 'LANGUAGE': 'en_US:en', 23:53:58 INFO - 'LOGNAME': 'cltbld', 23:53:58 INFO - 'MAIL': '/var/mail/cltbld', 23:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:53:58 INFO - 'MOZ_NO_REMOTE': '1', 23:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:53:58 INFO - 'NO_EM_RESTART': '1', 23:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:53:58 INFO - 'SHELL': '/bin/bash', 23:53:58 INFO - 'SHLVL': '1', 23:53:58 INFO - 'TERM': 'linux', 23:53:58 INFO - 'TMOUT': '86400', 23:53:58 INFO - 'USER': 'cltbld', 23:53:58 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:53:58 INFO - '_': '/tools/buildbot/bin/python'} 23:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:53:58 INFO - Downloading/unpacking flake8 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:53: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 23:54:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:54:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:54: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 23:54: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 23:54: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 23:54: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 23:54: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 23:54: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 23:54:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:54:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:54: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 23:54: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 23:54: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 23:54: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 23:54: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 23:54: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 23:54:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:54:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:54:01 INFO - no previously-included directories found matching 'docs/_build' 23:54:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:54:01 INFO - Running setup.py install for pep8 23:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:54:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:54:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:54:01 INFO - no previously-included directories found matching 'docs/_build' 23:54:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:54:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:54:01 INFO - Cleaning up... 23:54:01 INFO - Return code: 0 23:54:01 INFO - Running post-action listener: _resource_record_post_action 23:54:01 INFO - Running post-action listener: _start_resource_monitoring 23:54:01 INFO - Starting resource monitoring. 23:54:01 INFO - ##### 23:54:01 INFO - ##### Running install step. 23:54:01 INFO - ##### 23:54:01 INFO - Running pre-action listener: _resource_record_pre_action 23:54:01 INFO - Running main action method: install 23:54:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:54:01 INFO - Reading from file tmpfile_stdout 23:54:01 INFO - Detecting whether we're running mozinstall >=1.0... 23:54:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:54:02 INFO - Reading from file tmpfile_stdout 23:54:02 INFO - Output received: 23:54:02 INFO - Usage: mozinstall [options] installer 23:54:02 INFO - Options: 23:54:02 INFO - -h, --help show this help message and exit 23:54:02 INFO - -d DEST, --destination=DEST 23:54:02 INFO - Directory to install application into. [default: 23:54:02 INFO - "/builds/slave/test-pgo"] 23:54:02 INFO - --app=APP Application being installed. [default: firefox] 23:54:02 INFO - mkdir: /builds/slave/test-pgo/build/application 23:54:02 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'] 23:54:02 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 23:54:18 INFO - Reading from file tmpfile_stdout 23:54:18 INFO - Output received: 23:54:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:54:18 INFO - Running post-action listener: _resource_record_post_action 23:54:18 INFO - ##### 23:54:18 INFO - ##### Running run-tests step. 23:54:18 INFO - ##### 23:54:18 INFO - Running pre-action listener: _resource_record_pre_action 23:54:18 INFO - Running main action method: run_tests 23:54:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:54:18 INFO - Python 2.7.3 23:54:18 INFO - Return code: 0 23:54:18 INFO - grabbing minidump binary from tooltool 23:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:54:18 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 0x26d23f0>, '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 0x2764560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2764a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:54:18 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 23:54:18 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 23:54:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:54:18 INFO - Return code: 0 23:54:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:54:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:54:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:54:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:54:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:54:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:54:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:54:19 INFO - Return code: 0 23:54:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 23:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 23:54:19 INFO - Using env: {'DISPLAY': ':0', 23:54:19 INFO - 'HOME': '/home/cltbld', 23:54:19 INFO - 'LANG': 'en_US.UTF-8', 23:54:19 INFO - 'LANGUAGE': 'en_US:en', 23:54:19 INFO - 'LOGNAME': 'cltbld', 23:54:19 INFO - 'MAIL': '/var/mail/cltbld', 23:54:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:54:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:54:19 INFO - 'MOZ_NO_REMOTE': '1', 23:54:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:54:19 INFO - 'NO_EM_RESTART': '1', 23:54:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:54:19 INFO - 'PWD': '/builds/slave/test-pgo', 23:54:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:54:19 INFO - 'SHELL': '/bin/bash', 23:54:19 INFO - 'SHLVL': '1', 23:54:19 INFO - 'TERM': 'linux', 23:54:19 INFO - 'TMOUT': '86400', 23:54:19 INFO - 'USER': 'cltbld', 23:54:19 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159', 23:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:54:19 INFO - '_': '/tools/buildbot/bin/python'} 23:54:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 23:54:19 INFO - mozversion application_buildid: 20160121193151 23:54:19 INFO - mozversion application_changeset: c5da92c5b4906369dee83629f81d647226ac1038 23:54:19 INFO - mozversion application_display_name: Nightly 23:54:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:54:19 INFO - mozversion application_name: Firefox 23:54:19 INFO - mozversion application_remotingname: firefox 23:54:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:54:19 INFO - mozversion application_vendor: Mozilla 23:54:19 INFO - mozversion application_version: 46.0a1 23:54:19 INFO - mozversion platform_buildid: 20160121193151 23:54:19 INFO - mozversion platform_changeset: c5da92c5b4906369dee83629f81d647226ac1038 23:54:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:54:19 INFO - mozversion platform_version: 46.0a1 23:54:19 INFO - using testdate: 1453449259 23:54:19 INFO - actual date: 1453449259 23:54:19 INFO - starting webserver on 'localhost:54553' 23:54:19 INFO - SUITE-START | Running 3 tests 23:54:19 INFO - TEST-START | dromaeo_css 23:54:19 INFO - operating with platform_type : linux_ 23:54:19 INFO - Initialising browser for dromaeo_css test... 23:54:19 INFO - TEST-INFO | started process 16714 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgz1hsq/profile http://localhost:54553/getInfo.html) 23:54:23 INFO - PROCESS | 16714 | 23:54:23 INFO - PROCESS | 16714 | (process:16797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:54:24 INFO - PROCESS | 16714 | __metrics Screen width/height:1600/1200 23:54:24 INFO - PROCESS | 16714 | colorDepth:24 23:54:24 INFO - PROCESS | 16714 | Browser inner width/height: 1024/697 23:54:24 INFO - PROCESS | 16714 | __metrics 23:54:24 INFO - PROCESS | 16714 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:54:25 INFO - TEST-INFO | 16714: exit 0 23:54:25 INFO - Browser initialized. 23:54:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:54:25 INFO - TEST-INFO | started process 16846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgz1hsq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:54:26 INFO - PROCESS | 16846 | 23:54:26 INFO - PROCESS | 16846 | (process:16903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:54:36 INFO - PROCESS | 16846 | RSS: Main: 153432064 23:54:36 INFO - PROCESS | 16846 | 23:55:26 INFO - PROCESS | 16846 | 1453449326495 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] 23:57:35 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54553/tests/dromaeo/cssquery-ext.html) 23:57:36 INFO - PROCESS | 16846 | RSS: Main: 161832960 23:57:36 INFO - PROCESS | 16846 | 00:00:38 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-ext.html (next: http://localhost:54553/tests/dromaeo/cssquery-jquery.html) 00:00:39 INFO - PROCESS | 16846 | RSS: Main: 156909568 00:00:39 INFO - PROCESS | 16846 | 00:03:41 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54553/tests/dromaeo/cssquery-mootools.html) 00:03:41 INFO - PROCESS | 16846 | RSS: Main: 156925952 00:03:41 INFO - PROCESS | 16846 | 00:06:43 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54553/tests/dromaeo/cssquery-prototype.html) 00:06:43 INFO - PROCESS | 16846 | RSS: Main: 159989760 00:06:43 INFO - PROCESS | 16846 | 00:09:46 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54553/tests/dromaeo/cssquery-yui.html) 00:09:46 INFO - PROCESS | 16846 | RSS: Main: 157171712 00:09:46 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | Cycle 1(1): loaded http://localhost:54553/tests/dromaeo/cssquery-yui.html (next: http://localhost:54553/tests/dromaeo/cssquery-dojo.html) 00:12:49 INFO - PROCESS | 16846 | RSS: Main: 158617600 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | __start_tp_report 00:12:49 INFO - PROCESS | 16846 | _x_x_mozilla_page_load 00:12:49 INFO - PROCESS | 16846 | _x_x_mozilla_page_load_details 00:12:49 INFO - PROCESS | 16846 | |i|pagename|runs| 00:12:49 INFO - PROCESS | 16846 | |0;dojo.html;3207.374561960418;3216.6944140306678;3221.114193596762;3246.366958443103;3252.967470325296;5191.480851914806;5219.295395121658;5291.047611429941;5306.442823503535;5328.573714102872;5287.894242115165;5303.28405665236;5304.098303288441;5304.257403963448;5336.9733151334285;4822.758862056892;4840.87897802556;4850.07848508784;4913.606911447094;4926.9753651231695;4912.926306105412;4939.456659767423;4939.827106051289;4942.085714142877;4944.035912996967;4824.059308434857;4916.164252077156;4919.065377578267;4920.630952678545;4927.236278376839;4698.107359601665;4751.833685821014;4754.7147171169845;4845.3216549683075;4904.0437114762635;4807.42310922688;4812.7352995585225;4816.8795780105775;4819.831305904277;4854.805807767685;5023.572996295319;5124.128898087334;5152.124138896396;5161.561267292284;5182.352205974254;5605.663660180361;5648.265725455664;5648.604597678164;5707.086866101404;5744.080947048452;5782.9421705782825;5796.797112101099;5799.536037117021;5801.88396232073;5804.448577385184;5202;5282.973585132127;5404.810831620914;5408.188771684239;5432.91850622241;5757.625754325955;5799.594028417971;5803.506701930383;5837.591368604242;5856;5567.638103523258;5617.9719101404235;5624.71876406178;5626.521745651584;5635.9436405635415;5624.606277560613;5682.886342273131;5707.914381284284;5729.083346664514;5739.426057394227;5617.719114044281;5659.094544872883;5660.95272374612;5682.261306030189;5708.229389032511;5556.166575013699;5628.324601047901;5678.176664383641;5713.114467257582;5720;4341.522432532419;4391.077873646506;4397.494288156903;4452;4501.369808226851;3959.089409435788;3971.0667993021616;3996.9400458993136;4003.3594624859884;4022.1151346703678;5413.675179489164;5433.673979561239;5435.293411856513;5450.345958485007;5492.505674489315;5592.664440133605;5689.886202275931;5694.829155125353;5772.336181339116;5836.824895253149;5336.332958380202;5384.434634363413;5409.134538473904;5419.864503387368;5427.48438898304;4898.53463920927;4926.433460152057;4942.654014219042;4956.553910148032;4999.525045120708;5760.423957604206;5801.477866991991;5901.527877769769;5929.822105336847;6002.159697642333;5731.226284451545;5732.312122545154;5757.280339957505;5779.104238842986;5780.653160810365;5764.682942438206;5931.051031835058;5969.224000879858;5981.371955944737;5986.640801551921;5609.354924183771;5627.324721033502;5643.830685079454;5661.85845353853;5667.546596272371;5646.689432081275;5650.378458369658;5678.602497825278;5684.7157642118555;5693.146028095819;5506.889862202814;5563.026470367588;5570.554355651457;5575.609707320448;5579.637323573955;5479.0959491683425;5520.585956053393;5578.553715702815;5592.692401917933;5641.182028605911;5496.7526461308535;5499.642523235977;5500.697461639648;5501.001854549562;5512.6692398456225;5645.1532270159805;5657.462541058593;5659.434056594308;5667.093265077733;5685.374608792947;5339.519443250126;5365.2220428036935;5454.318210223722;5505.779768809202;5557.610967232255 00:12:49 INFO - PROCESS | 16846 | |1;ext.html;518.1321286844537;520.9531142197202;540.354276639416;540.4298465119299;549.2393035645634;35841;36744.26511469769;36909;36980.26039479209;37122.628773712255;39627.20745585087;39776.20447591046;40078.59921400785;40168.598314016854;40206.79379618616;8379.832403351915;8499.532525711084;8627.137286271385;8665.740027799176;8720.30237580992;8316.126806685272;8478.025027121867;8518.105598912118;8523.701670441536;8532.70135545256;8563.614637341303;8797.516136612483;8807.559622018873;8808.427452215617;8820.691275805348;8683.13168683133;8731.60707768152;8779.78050548735;8781.473111613292;8797.164269394398;8559.358048146414;8698.304135669132;8713.564321783886;8730.781730456789;8739.825203495959;38919.61080389217;39602.60397396047;39614.60385396167;39705.40441893374;39720.80139599313;3091.3199096199023;3421.0250078727445;3448.741344399155;3512.824358782076;3565.607783143852;29663.25841853949;29784.70215297841;29824.8508757457;30026.399472010657;30935.690643093505;3733.085394078468;3768.924621507582;3809.4095415210686;3816.713746468998;3852.5184351956004;252045.99999999817;253055;253517;254614;255188.7240563804;41268.38097428541;41636.37545436821;41951.58048419538;42157.367639485434;42158.57841421608;40424.59575404267;40511.797441013194;40607.593924060384;40858.59141408548;40912.38631420531;13076.476940922257;13081.672958175932;13214.735705286033;13217.471301148038;13248.536301229411;11229.606963756229;11245.15661325404;11293.265937714023;11297.152713546517;11320.207585468937;14528.418863245563;14612.342444590018;14643.853561464462;14688.118712877262;14688.19214943167;5740.54075673945;5809.7095145242565;5818.563607729353;5890.558208134321;5953.851153721192;903.5482258870564;916.1159481100636;1002.684154491333;1006.3659894266711;1083.06315037492;28476.288092797433;32532.83733581317;32929.67070329314;33236.1690957728;33799;996.461910568285;1024.2267088348249;1055.7835643693024;1090;1131.2929419113054;14573.417063317349;14591.78112328316;14594.927025364805;14598;16399;279847;284015;284847;285861;286202;50651.49348506542;52021.47978520166;52055.73972130115;52066.21900671493;52273.7386313066;1260.703734622363;1261.0479088288284;1292.2375798278872;1318.4330737782846;1333.2067419885152;28098.438031239668;29269;30213;30994.22514437067;31383.372332552764;44765.77617111894;45126.54873451223;45216;45583;45623.31565026461;294819;294981;294998;295746;296608;41484.37773433341;41767.791161044;42076.78961605173;42449.36325955175;42580.78709606432;39386.40920386254;40502.79748601238;40876.59123408728;42662.78668606637;43379.566204338815;35397.82301088478;35585;35968.64031359758;36956.44565331576;37144.442833358065;36080.45879311865;36413.817930910176;36487.81756091202;36666.45000325051;36875.63124368722;37798.62201377951;37824.243515130096;38576.614233857304;38898;39129;28993;29310.26724331909;31566.526502102945;31622.525662114625;31679.84160079185;23499.412514686584;24749.62875556832;26295.868520657274;27628.861855691397;28154.85922570374 00:12:49 INFO - PROCESS | 16846 | |2;jquery.html;349.12195827493855;353.1154458082504;353.3604176440643;353.90090774583126;354.19597513644027;15433.69132617347;15773.684526309482;16652.75020874688;16878.409255676055;17569.91215043923;15530;15850.445234416798;16126.435574754885;16620.25208865601;16731.665366692658;4797.784099715513;4959.181735013718;4978.452370239289;4980.003999200157;4980.477049909761;4814.109389762888;4901.975490122562;4925.38432695913;5432.83701488954;5456.536194423479;5103.055934652083;5289.497497737709;5290.1800220965815;5421.972890135544;5460.781568737246;5230.895382092356;5257.158854583267;5261.710605916654;5629.380768115545;6074.210352654127;5425.050616142199;5428.864278393033;5430.266913966603;5459.2902922619805;5481.561475081984;12270.81593776094;12547.24716517012;12754.234745915182;12805.807912881315;12821.743565128645;2033.5729496805689;2050.0877109686194;2084.937451876446;2143.9142434302607;2225.0209907640588;8941.016488186295;9132.36073474857;9202.53987300639;9292.674756383494;10767.6231331903;1718.5445856847946;1734.8785585009055;1762.2422358385888;1820.963580728378;1837.4855040588657;54718.452815472134;55634;55680.44319556834;55701.44298557003;55724;10370.948145259226;10376.636817711344;10404.479776011169;10405.115565177044;10481.580736770444;13417.396217170251;13442.260675662932;13549.864501355058;13621.387037583332;13626.250556219306;7212.963935180395;7289.4168466523615;7333.1933487316355;7336.229695881855;7361.1166660001145;6800.183977922681;7005.789826305219;7025;7067.540609860343;7074.469414793911;4425.668074894395;4474.149911516802;4514.210013247669;4537.500874903758;4539.727616342964;1779.5195297269665;1818.4544636608964;1857.8792378495355;1885.8585606079598;1892.858035647332;408.4547129581982;788.4480863395646;853.9146085391535;917.9862302065341;958.152035448619;10223.386596804216;10672.30630009047;10803.351798891934;10948.781024379468;11049.944750276198;436.312807328459;452.64693539039604;453.7459022947094;460.9285560738091;479.27150730888854;5592.720363981784;5774.191613174159;5783.2192653992015;5886.735096920649;5903.490504614746;465422;474611;497464;512224;513784;45371.54628453739;69955;72332.63833680798;72998;73430;1090.334895713614;1111.777644471109;1123.6067376418189;1125.7129431994788;1159.9710007249716;13764.518241861486;14191.503297384543;14525.782113268098;14805.629859253175;14904.925475372555;29279.707202928552;29661;30582;30640.387192255585;30705.846470767505;33009.66990330066;33781.493277601345;34292.314153717285;35034.474482883285;36087;6760.932390676227;6871.381575658214;7045.26024767392;7286.198518162892;7345.118585769528;8610.78473038179;10269;10500.684979450629;10567;10808.405537695502;8662.350323725872;9083.863742043743;9487.810243794947;9859.605615775288;10077.748056298651;9147.496887670975;9962;9983.301168918106;10013.14888234479;10203.336783109075;9618.326717129734;9698.933117357226;9793.608255669978;9985.1512621428;10095.596176152872;6671.132752742306;6785.93214067853;7155.964220178866;7204.891926621;7264.346208841018;8100.554469504234;9478.526073696425;9555.123798136856;9737.805243895224;9842.901570984484 00:12:49 INFO - PROCESS | 16846 | |3;mootools.html;1233.3093467658116;1239.5847391123973;1275.929823859688;1427.143713771737;1432.1478720161513;7366.889496657554;7428.4428667849925;7582.241775822415;7654.846903061935;7663.157052724196;7585.279398457152;7604.391648668107;7615.5811430371305;7652.502587331819;7654.502457340269;2292.4383526036145;2293.8738369389675;2293.919712810052;2300.9884950575224;2312.8034117100065;2202.0971401725296;2238.50752834377;2250.7861753133425;2251.34710933829;2264.841461097724;2242.1816037146405;2276.9544609107807;2295.9426014349606;2320.5706944215376;2320.825938054644;2237.9552408951813;2240;2254.7068881045443;2268.7958083772373;2271.534335461243;2235.944101397462;2256.5035692147867;2263.694401255826;2264.30938563738;2264.4225722440674;7437;7455.925440745577;7487.363574096208;7505.924940750577;7523.3229009389415;4508.932366014513;4616.076784643051;4629.0279041401345;4643.3963584733765;4676.7427791471455;2916.1543152485756;2957.852107394643;2973.9851300743358;2985.4924662807157;2986.4325778102093;945.2343601682659;963.2775418436173;970.898055704155;981.8772653418323;991.2912267728609;10071.093601575893;10170.084692377648;10195.337303075275;10226.53980570876;10241.692749217535;4051.716379853441;4057.756534607933;4084.7344922579937;4086.223617512663;4255.893602659897;8220.958895205606;8280.337572994145;8330.375221858385;8333.791655208546;8338.499690018618;4655.068986202706;4681.368015317888;4700.694454860423;4709.105269998689;4736.3369128322065;4310.482742070972;4340.240457919915;4341.044970106572;4346.826126954949;4355.542668019875;3480.112571294304;3484.094135524782;3509.8771542996383;3519.7008254298157;3538;1043.400044974143;1050.1336397472116;1053;1055.4300677634146;1058.2010582010687;944.2398868910456;949.1457688080783;985.3693636072919;992.9056739609725;1159.2059439284117;7006.124234470692;7070.292970702889;7097.112860892388;7113.857722845514;7170.1754298256365;1088.7169335972703;1106.4744246482855;1125.426032723317;1126.9605563805228;1137.5392965848844;4917.409910810726;4919.114559379346;4947.5794557462295;4948.134076536664;4994.126027945095;8932.151445612657;8946.821063578693;9214.815703685888;9341;9407.247420206504;9115.635374585076;9198.862017069749;9209.263258939269;9248.121428464285;9257.537123143817;6809.285025072296;6992.300769922967;6997.47518936092;7228.96385518069;7407.333339999426;7128.073350464614;7162.964185179041;7179.210286868545;7201.603911784692;7202.603856787927;7967.880481792662;8310.792230194293;8409.789755256168;8426.789330266793;8573.485590864568;7727;7830.804229894298;7872.409569282212;7894.921050789419;7903.209679032051;6194.132821404917;6345.397187267202;6620.602763834186;6653.800385988428;6676.399124078856;6918.515703900679;6919.238883722887;6920.896186557105;6937.236903940461;6941.167059952838;6531.640759758259;6624;6700.061991321317;6764.2221144569;6806.863862722619;6479.352064793483;6488.480921526361;6632.137822083098;6649.867002659823;6702.128723265944;6306.46395056407;6311.116443697794;6543.214814222324;6566.507511936528;6569.113169722217;6135.785247516315;6196.411340922605;6213.689315534115;6241.78153764616;6243.687815609293;6198.101275315144;6309.526785491014;6319.115323854572;6376.234851817626;6394.360563943755 00:12:49 INFO - PROCESS | 16846 | |4;prototype.html;334.2729563200039;334.7271973341726;343.29452974138144;344.63985135533363;346.50622862421045;6133.049377346519;6260.749570017194;6325.082862984865;6328.715207815648;6337.239531256244;6081.209442772444;6238.4697300729495;6257.749690012405;6259.280182778971;6282.434580887719;4801.207800712878;4803.663743537953;4805.399325084364;4806.471288158317;4806.807727690888;4816.253480710478;4816.349792777983;4819.542143496362;4822.782974766126;4831.9275210871865;4690.179218636742;4780.521947805227;4797.472278049412;4798.304245884362;4800.279958006309;4753.90492190156;4764.2615394613895;4772.976135119319;4773.307870358796;4781.737004464753;3928.391099379572;4067.145899361108;4219.894502637428;4223.831046758126;4224.324108142713;5827.300723913115;5896.7936122235515;5960.403959604048;5992.191054207669;6007;5553.4172760763395;5572.164175373686;5575.804846830341;5584.301962254718;5603.851210501837;6485.448736857373;6672.699728512229;6680.1983761948395;6680.632565208912;6690.464762818963;4679.087577922306;4679.60223381013;4685.250359942427;4688.929666055012;4694.624430045622;6917.688704008332;6967.6167810770385;6982;6985.89521157183;6991.265917078685;4766.070616229802;4813.831515896997;4815.277708343707;4823.1800593899125;4825.469198388175;4606.884827879263;4739.928901066487;4744.383230180055;4882.487338829443;4883.218685010453;5500.147477141049;5550.888982220333;5555.500004999489;5559.861003474864;5577.135543990688;6706.061151438803;6713.765018224436;6720.193576770819;6742.932570674328;6761.0872532208505;1655.1806855606312;1696.4571337171988;1699.6402877697792;1701.3534856754354;1703.2931333496708;1085.8968398002178;1111.6776134920783;1112.477135746198;1123.6514688156885;1125.386664267976;6299.559030867796;6302.905456418157;6311.652859092702;6320.367963203735;6339.270983836917;6796.8300792479595;6802.047713320139;6807.931920680829;6821.727130914708;6848.760293389708;6177.289611694623;6200.56596038282;6243.532769799093;6245.75016999324;6258.499320054385;3674.430463278196;3683.1712864605784;3748.55017397914;3767.7362584619364;3771.2834561433788;7138.928610713826;7271.163816161104;7306.561606303639;7319.597422141726;7330.230325815819;7058.329458701415;7084.185318688416;7113.53762005468;7127.89308160378;7136.393406560397;7134.607596582134;7250.948612451165;7279.563226206445;7284.781456556206;7300.707971681286;7023.789286321418;7071.7878463646175;7078.256783037707;7078.858422831411;7080.929190708027;6827.6244806536115;6845.486588505982;6876.656167191721;6878.828029299308;6915.585064896122;7070.540414873017;7231.385332246818;7251.746188883364;7302.3792977597495;7303.269673032654;4633.976830115827;4634.698744581591;4656.8137274508645;4665.743384113906;4671.556202160789;6902.482313826584;6920.826979325557;6960.512764106464;6986.790396288119;6997.895031574429;6613.603183808987;6744.730210791513;6761.290064543349;6781.89827152603;6790.93209067903;6699.062131301719;6745.089412929388;6761.797146085625;6768;6772.52592318533;6549.803505894831;6567.44176744982;6576.243731970884;6616.503762217757;6617.305182955721;6636.104125942936;6751.831204219934;6791.524593278423;6819.147606549182;6820.761273355409;6589.17635295588;6598.274189839018;6654.3012983637955;6657.101291325609;6658.766943156967 00:12:49 INFO - PROCESS | 16846 | |5;yui.html;772.0276933804848;822.296936119618;830.1490971753951;830.8130670599114;832.8417600655879;12033.51865925363;12147.028237740982;12152.513899444033;12157.331346775924;12218.877811221884;11710.707232319175;11716.355600441972;11728.706782330446;11745.354005529693;11777.05783537317;779.364817673597;799.2087833045273;800.1758189065272;802.0215337288498;802.1377019703842;550.2379204801339;564.5793883556756;566.8214512428572;568.9004424225765;794.6860989908982;838.0153319849184;838.5639467476908;838.7022606974527;840.8948881389827;841.6002398860553;828.6146941672122;830.1739768929954;830.3025458614793;833.0669649992018;837.1921096142252;605.8485378655337;608.856918624123;609.6464050850541;610.1823556434355;615.1910238036967;11988.100892433102;12041.518339266418;12095.818562721566;12124.090693197957;12135.361726166942;11823.994960428374;11966.700832479257;11975.88024119765;12183;12391.566295179626;9754.561044753003;9830.655927042591;10018.098371146632;10344.5344959477;10526.578936842594;3407.4037043517533;3462.9480557791653;3504.1489959380083;3518.894433167009;3626.202235508184;47099.76450117728;47388.76305618484;47516;47590.28614570784;47753.761231193625;9669.90330096704;9822.312438129406;9859.26055545837;9878.851817222747;10123.696289111338;17745.290188392577;17813.554661133574;17862.55343616394;17868.285268589112;17876.55308617295;7458.776236712907;7524.021877155935;7524.811879703051;7580.924190758132;7743.728969486041;4104.445899803488;4136.73111247768;4152.190322887069;4254.595813397722;4448.154850578379;2931.560265960123;2961.08206455995;2964.777641676883;2964.836933968609;2968.09473110699;579.2701196492366;585.4672248254068;586.2847326261954;601.8886505996404;605.3129697793037;513.3531749995033;561.8342588936192;566.2157911292888;585.0843430032071;635.3646353646353;7796.961015195001;7936.642851071716;8056.919430805734;8071.192880711882;8245.299149572234;591.4647244243966;616.5529990756665;621.8973869311603;635.8124353315783;638.5211091681239;3966;4047.1298670785923;4180.163967206571;4195.4336164618;4252.340887162495;53115.46884531183;53884;54154.729226353615;54162;55235.44764552303;48219;48244;48267.5173248263;48305.27542086872;49016.50983490191;43452.78273608612;43788.12423751571;44559.33161002523;44602.55397445984;44885.55114448879;8680.78298042554;8795.824083518422;8858.867116993122;8860.379773416056;8937.910620893708;32713.836430817693;32807.50788738123;32960.505592415655;33407.33185336231;33979.32041359109;40487.392689109096;42498;42608;42808.357874631285;43075.353869692604;10266.127379172854;11076.446177690923;11172.776544469227;11432.714182145513;11450.08399328035;11905.107116966436;11976.820347694966;12063.155579109378;12709.872901270868;12754.42605082755;10285.691429256834;10702.83945740799;11367.54529818798;11467.31196128235;11843.348615826213;10325.535350909076;10529.42088185157;10612.310199836986;10645.627403040857;10684.198685098494;9704.466254356079;10291.176705863363;10335.121514671337;10378.06597406237;10527.052565268856;8809.779755506164;9098.772530686785;9182.127697868691;9191.586378613112;9296.72109836706;8555;8755.51844648525;8821.955890220508;9266.258699303904;9337.346385752931 00:12:49 INFO - PROCESS | 16846 | __end_tp_report 00:12:49 INFO - PROCESS | 16846 | __start_cc_report 00:12:49 INFO - PROCESS | 16846 | _x_x_mozilla_cycle_collect,312 00:12:49 INFO - PROCESS | 16846 | __end_cc_report 00:12:49 INFO - PROCESS | 16846 | __startTimestamp1453450369536__endTimestamp 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | ------- Summary: start ------- 00:12:49 INFO - PROCESS | 16846 | Number of tests: 6 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#0] dojo.html Cycles:165 Average:5303.94 Median:5501.00 stddev:575.64 (10.5%) stddev-sans-first:553.41 00:12:49 INFO - PROCESS | 16846 | Values: 3207.4 3216.7 3221.1 3246.4 3253.0 5191.5 5219.3 5291.0 5306.4 5328.6 5287.9 5303.3 5304.1 5304.3 5337.0 4822.8 4840.9 4850.1 4913.6 4927.0 4912.9 4939.5 4939.8 4942.1 4944.0 4824.1 4916.2 4919.1 4920.6 4927.2 4698.1 4751.8 4754.7 4845.3 4904.0 4807.4 4812.7 4816.9 4819.8 4854.8 5023.6 5124.1 5152.1 5161.6 5182.4 5605.7 5648.3 5648.6 5707.1 5744.1 5782.9 5796.8 5799.5 5801.9 5804.4 5202.0 5283.0 5404.8 5408.2 5432.9 5757.6 5799.6 5803.5 5837.6 5856.0 5567.6 5618.0 5624.7 5626.5 5635.9 5624.6 5682.9 5707.9 5729.1 5739.4 5617.7 5659.1 5661.0 5682.3 5708.2 5556.2 5628.3 5678.2 5713.1 5720.0 4341.5 4391.1 4397.5 4452.0 4501.4 3959.1 3971.1 3996.9 4003.4 4022.1 5413.7 5433.7 5435.3 5450.3 5492.5 5592.7 5689.9 5694.8 5772.3 5836.8 5336.3 5384.4 5409.1 5419.9 5427.5 4898.5 4926.4 4942.7 4956.6 4999.5 5760.4 5801.5 5901.5 5929.8 6002.2 5731.2 5732.3 5757.3 5779.1 5780.7 5764.7 5931.1 5969.2 5981.4 5986.6 5609.4 5627.3 5643.8 5661.9 5667.5 5646.7 5650.4 5678.6 5684.7 5693.1 5506.9 5563.0 5570.6 5575.6 5579.6 5479.1 5520.6 5578.6 5592.7 5641.2 5496.8 5499.6 5500.7 5501.0 5512.7 5645.2 5657.5 5659.4 5667.1 5685.4 5339.5 5365.2 5454.3 5505.8 5557.6 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#1] ext.html Cycles:180 Average:44077.03 Median:37133.54 stddev:72532.02 (195.3%) stddev-sans-first:72661.76 00:12:49 INFO - PROCESS | 16846 | Values: 518.1 521.0 540.4 540.4 549.2 35841.0 36744.3 36909.0 36980.3 37122.6 39627.2 39776.2 40078.6 40168.6 40206.8 8379.8 8499.5 8627.1 8665.7 8720.3 8316.1 8478.0 8518.1 8523.7 8532.7 8563.6 8797.5 8807.6 8808.4 8820.7 8683.1 8731.6 8779.8 8781.5 8797.2 8559.4 8698.3 8713.6 8730.8 8739.8 38919.6 39602.6 39614.6 39705.4 39720.8 3091.3 3421.0 3448.7 3512.8 3565.6 29663.3 29784.7 29824.9 30026.4 30935.7 3733.1 3768.9 3809.4 3816.7 3852.5 252046.0 253055.0 253517.0 254614.0 255188.7 41268.4 41636.4 41951.6 42157.4 42158.6 40424.6 40511.8 40607.6 40858.6 40912.4 13076.5 13081.7 13214.7 13217.5 13248.5 11229.6 11245.2 11293.3 11297.2 11320.2 14528.4 14612.3 14643.9 14688.1 14688.2 5740.5 5809.7 5818.6 5890.6 5953.9 903.5 916.1 1002.7 1006.4 1083.1 28476.3 32532.8 32929.7 33236.2 33799.0 996.5 1024.2 1055.8 1090.0 1131.3 14573.4 14591.8 14594.9 14598.0 16399.0 279847.0 284015.0 284847.0 285861.0 286202.0 50651.5 52021.5 52055.7 52066.2 52273.7 1260.7 1261.0 1292.2 1318.4 1333.2 28098.4 29269.0 30213.0 30994.2 31383.4 44765.8 45126.5 45216.0 45583.0 45623.3 294819.0 294981.0 294998.0 295746.0 296608.0 41484.4 41767.8 42076.8 42449.4 42580.8 39386.4 40502.8 40876.6 42662.8 43379.6 35397.8 35585.0 35968.6 36956.4 37144.4 36080.5 36413.8 36487.8 36666.5 36875.6 37798.6 37824.2 38576.6 38898.0 39129.0 28993.0 29310.3 31566.5 31622.5 31679.8 23499.4 24749.6 26295.9 27628.9 28154.9 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#2] jquery.html Cycles:180 Average:25153.26 Median:470016.50 stddev:80570.74 (17.1%) stddev-sans-first:80775.23 00:12:49 INFO - PROCESS | 16846 | Values: 349.1 353.1 353.4 353.9 354.2 15433.7 15773.7 16652.8 16878.4 17569.9 15530.0 15850.4 16126.4 16620.3 16731.7 4797.8 4959.2 4978.5 4980.0 4980.5 4814.1 4902.0 4925.4 5432.8 5456.5 5103.1 5289.5 5290.2 5422.0 5460.8 5230.9 5257.2 5261.7 5629.4 6074.2 5425.1 5428.9 5430.3 5459.3 5481.6 12270.8 12547.2 12754.2 12805.8 12821.7 2033.6 2050.1 2084.9 2143.9 2225.0 8941.0 9132.4 9202.5 9292.7 10767.6 1718.5 1734.9 1762.2 1821.0 1837.5 54718.5 55634.0 55680.4 55701.4 55724.0 10370.9 10376.6 10404.5 10405.1 10481.6 13417.4 13442.3 13549.9 13621.4 13626.3 7213.0 7289.4 7333.2 7336.2 7361.1 6800.2 7005.8 7025.0 7067.5 7074.5 4425.7 4474.1 4514.2 4537.5 4539.7 1779.5 1818.5 1857.9 1885.9 1892.9 408.5 788.4 853.9 918.0 958.2 10223.4 10672.3 10803.4 10948.8 11049.9 436.3 452.6 453.7 460.9 479.3 5592.7 5774.2 5783.2 5886.7 5903.5 465422.0 474611.0 497464.0 512224.0 513784.0 45371.5 69955.0 72332.6 72998.0 73430.0 1090.3 1111.8 1123.6 1125.7 1160.0 13764.5 14191.5 14525.8 14805.6 14904.9 29279.7 29661.0 30582.0 30640.4 30705.8 33009.7 33781.5 34292.3 35034.5 36087.0 6760.9 6871.4 7045.3 7286.2 7345.1 8610.8 10269.0 10500.7 10567.0 10808.4 8662.4 9083.9 9487.8 9859.6 10077.7 9147.5 9962.0 9983.3 10013.1 10203.3 9618.3 9698.9 9793.6 9985.2 10095.6 6671.1 6785.9 7156.0 7204.9 7264.3 8100.6 9478.5 9555.1 9737.8 9842.9 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#3] mootools.html Cycles:180 Average:5241.84 Median:6315.12 stddev:2701.83 (42.8%) stddev-sans-first:2692.60 00:12:49 INFO - PROCESS | 16846 | Values: 1233.3 1239.6 1275.9 1427.1 1432.1 7366.9 7428.4 7582.2 7654.8 7663.2 7585.3 7604.4 7615.6 7652.5 7654.5 2292.4 2293.9 2293.9 2301.0 2312.8 2202.1 2238.5 2250.8 2251.3 2264.8 2242.2 2277.0 2295.9 2320.6 2320.8 2238.0 2240.0 2254.7 2268.8 2271.5 2235.9 2256.5 2263.7 2264.3 2264.4 7437.0 7455.9 7487.4 7505.9 7523.3 4508.9 4616.1 4629.0 4643.4 4676.7 2916.2 2957.9 2974.0 2985.5 2986.4 945.2 963.3 970.9 981.9 991.3 10071.1 10170.1 10195.3 10226.5 10241.7 4051.7 4057.8 4084.7 4086.2 4255.9 8221.0 8280.3 8330.4 8333.8 8338.5 4655.1 4681.4 4700.7 4709.1 4736.3 4310.5 4340.2 4341.0 4346.8 4355.5 3480.1 3484.1 3509.9 3519.7 3538.0 1043.4 1050.1 1053.0 1055.4 1058.2 944.2 949.1 985.4 992.9 1159.2 7006.1 7070.3 7097.1 7113.9 7170.2 1088.7 1106.5 1125.4 1127.0 1137.5 4917.4 4919.1 4947.6 4948.1 4994.1 8932.2 8946.8 9214.8 9341.0 9407.2 9115.6 9198.9 9209.3 9248.1 9257.5 6809.3 6992.3 6997.5 7229.0 7407.3 7128.1 7163.0 7179.2 7201.6 7202.6 7967.9 8310.8 8409.8 8426.8 8573.5 7727.0 7830.8 7872.4 7894.9 7903.2 6194.1 6345.4 6620.6 6653.8 6676.4 6918.5 6919.2 6920.9 6937.2 6941.2 6531.6 6624.0 6700.1 6764.2 6806.9 6479.4 6488.5 6632.1 6649.9 6702.1 6306.5 6311.1 6543.2 6566.5 6569.1 6135.8 6196.4 6213.7 6241.8 6243.7 6198.1 6309.5 6319.1 6376.2 6394.4 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#4] prototype.html Cycles:180 Average:5599.13 Median:6271.59 stddev:1705.28 (27.2%) stddev-sans-first:1663.65 00:12:49 INFO - PROCESS | 16846 | Values: 334.3 334.7 343.3 344.6 346.5 6133.0 6260.7 6325.1 6328.7 6337.2 6081.2 6238.5 6257.7 6259.3 6282.4 4801.2 4803.7 4805.4 4806.5 4806.8 4816.3 4816.3 4819.5 4822.8 4831.9 4690.2 4780.5 4797.5 4798.3 4800.3 4753.9 4764.3 4773.0 4773.3 4781.7 3928.4 4067.1 4219.9 4223.8 4224.3 5827.3 5896.8 5960.4 5992.2 6007.0 5553.4 5572.2 5575.8 5584.3 5603.9 6485.4 6672.7 6680.2 6680.6 6690.5 4679.1 4679.6 4685.3 4688.9 4694.6 6917.7 6967.6 6982.0 6985.9 6991.3 4766.1 4813.8 4815.3 4823.2 4825.5 4606.9 4739.9 4744.4 4882.5 4883.2 5500.1 5550.9 5555.5 5559.9 5577.1 6706.1 6713.8 6720.2 6742.9 6761.1 1655.2 1696.5 1699.6 1701.4 1703.3 1085.9 1111.7 1112.5 1123.7 1125.4 6299.6 6302.9 6311.7 6320.4 6339.3 6796.8 6802.0 6807.9 6821.7 6848.8 6177.3 6200.6 6243.5 6245.8 6258.5 3674.4 3683.2 3748.6 3767.7 3771.3 7138.9 7271.2 7306.6 7319.6 7330.2 7058.3 7084.2 7113.5 7127.9 7136.4 7134.6 7250.9 7279.6 7284.8 7300.7 7023.8 7071.8 7078.3 7078.9 7080.9 6827.6 6845.5 6876.7 6878.8 6915.6 7070.5 7231.4 7251.7 7302.4 7303.3 4634.0 4634.7 4656.8 4665.7 4671.6 6902.5 6920.8 6960.5 6986.8 6997.9 6613.6 6744.7 6761.3 6781.9 6790.9 6699.1 6745.1 6761.8 6768.0 6772.5 6549.8 6567.4 6576.2 6616.5 6617.3 6636.1 6751.8 6791.5 6819.1 6820.8 6589.2 6598.3 6654.3 6657.1 6658.8 00:12:49 INFO - PROCESS | 16846 | 00:12:49 INFO - PROCESS | 16846 | [#5] yui.html Cycles:180 Average:13178.25 Median:47553.14 stddev:15185.26 (31.9%) stddev-sans-first:15199.28 00:12:49 INFO - PROCESS | 16846 | Values: 772.0 822.3 830.1 830.8 832.8 12033.5 12147.0 12152.5 12157.3 12218.9 11710.7 11716.4 11728.7 11745.4 11777.1 779.4 799.2 800.2 802.0 802.1 550.2 564.6 566.8 568.9 794.7 838.0 838.6 838.7 840.9 841.6 828.6 830.2 830.3 833.1 837.2 605.8 608.9 609.6 610.2 615.2 11988.1 12041.5 12095.8 12124.1 12135.4 11824.0 11966.7 11975.9 12183.0 12391.6 9754.6 9830.7 10018.1 10344.5 10526.6 3407.4 3462.9 3504.1 3518.9 3626.2 47099.8 47388.8 47516.0 47590.3 47753.8 9669.9 9822.3 9859.3 9878.9 10123.7 17745.3 17813.6 17862.6 17868.3 17876.6 7458.8 7524.0 7524.8 7580.9 7743.7 4104.4 4136.7 4152.2 4254.6 4448.2 2931.6 2961.1 2964.8 2964.8 2968.1 579.3 585.5 586.3 601.9 605.3 513.4 561.8 566.2 585.1 635.4 7797.0 7936.6 8056.9 8071.2 8245.3 591.5 616.6 621.9 635.8 638.5 3966.0 4047.1 4180.2 4195.4 4252.3 53115.5 53884.0 54154.7 54162.0 55235.4 48219.0 48244.0 48267.5 48305.3 49016.5 43452.8 43788.1 44559.3 44602.6 44885.6 8680.8 8795.8 8858.9 8860.4 8937.9 32713.8 32807.5 32960.5 33407.3 33979.3 40487.4 42498.0 42608.0 42808.4 43075.4 10266.1 11076.4 11172.8 11432.7 11450.1 11905.1 11976.8 12063.2 12709.9 12754.4 10285.7 10702.8 11367.5 11467.3 11843.3 10325.5 10529.4 10612.3 10645.6 10684.2 9704.5 10291.2 10335.1 10378.1 10527.1 8809.8 9098.8 9182.1 9191.6 9296.7 8555.0 8755.5 8822.0 9266.3 9337.3 00:12:49 INFO - PROCESS | 16846 | -------- Summary: end -------- 00:12:49 INFO - PROCESS | 16846 | 00:12:50 INFO - TEST-INFO | 16846: exit 0 00:12:50 INFO - TEST-OK | dromaeo_css | took 1110811ms 00:12:50 INFO - TEST-START | kraken 00:12:50 INFO - operating with platform_type : linux_ 00:12:50 INFO - Initialising browser for kraken test... 00:12:50 INFO - TEST-INFO | started process 17085 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDs40hR/profile http://localhost:54553/getInfo.html) 00:12:53 INFO - PROCESS | 17085 | 00:12:53 INFO - PROCESS | 17085 | (process:17158): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:12:54 INFO - PROCESS | 17085 | __metrics Screen width/height:1600/1200 00:12:54 INFO - PROCESS | 17085 | colorDepth:24 00:12:54 INFO - PROCESS | 17085 | Browser inner width/height: 1024/697 00:12:54 INFO - PROCESS | 17085 | __metrics 00:12:54 INFO - PROCESS | 17085 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:12:55 INFO - TEST-INFO | 17085: exit 0 00:12:55 INFO - Browser initialized. 00:12:55 INFO - Running cycle 1/1 for kraken test... 00:12:55 INFO - TEST-INFO | started process 17207 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDs40hR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:12:57 INFO - PROCESS | 17207 | 00:12:57 INFO - PROCESS | 17207 | (process:17266): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:13:07 INFO - PROCESS | 17207 | RSS: Main: 153505792 00:13:07 INFO - PROCESS | 17207 | 00:13:10 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection) 00:13:10 INFO - PROCESS | 17207 | RSS: Main: 158146560 00:13:10 INFO - PROCESS | 17207 | 00:13:13 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-dft) 00:13:13 INFO - PROCESS | 17207 | RSS: Main: 160989184 00:13:13 INFO - PROCESS | 17207 | 00:13:16 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-fft) 00:13:17 INFO - PROCESS | 17207 | RSS: Main: 152711168 00:13:17 INFO - PROCESS | 17207 | 00:13:19 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator) 00:13:20 INFO - PROCESS | 17207 | RSS: Main: 153141248 00:13:20 INFO - PROCESS | 17207 | 00:13:22 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:13:23 INFO - PROCESS | 17207 | RSS: Main: 153411584 00:13:23 INFO - PROCESS | 17207 | 00:13:26 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom) 00:13:26 INFO - PROCESS | 17207 | RSS: Main: 154992640 00:13:26 INFO - PROCESS | 17207 | 00:13:30 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate) 00:13:30 INFO - PROCESS | 17207 | RSS: Main: 155598848 00:13:30 INFO - PROCESS | 17207 | 00:13:33 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial) 00:13:33 INFO - PROCESS | 17207 | RSS: Main: 156086272 00:13:33 INFO - PROCESS | 17207 | 00:13:35 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:13:36 INFO - PROCESS | 17207 | RSS: Main: 157130752 00:13:36 INFO - PROCESS | 17207 | 00:13:37 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:13:38 INFO - PROCESS | 17207 | RSS: Main: 156651520 00:13:38 INFO - PROCESS | 17207 | 00:13:40 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:13:41 INFO - PROCESS | 17207 | RSS: Main: 156930048 00:13:41 INFO - PROCESS | 17207 | 00:13:43 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:13:44 INFO - PROCESS | 17207 | RSS: Main: 156962816 00:13:44 INFO - PROCESS | 17207 | 00:13:46 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:13:47 INFO - PROCESS | 17207 | RSS: Main: 158281728 00:13:47 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | Cycle 1(1): loaded http://localhost:54553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54553/tests/kraken/driver.html?testName=ai-astar) 00:13:49 INFO - PROCESS | 17207 | RSS: Main: 158584832 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | __start_tp_report 00:13:49 INFO - PROCESS | 17207 | _x_x_mozilla_page_load 00:13:49 INFO - PROCESS | 17207 | _x_x_mozilla_page_load_details 00:13:49 INFO - PROCESS | 17207 | |i|pagename|runs| 00:13:49 INFO - PROCESS | 17207 | |0;ai-astar;113;110;114;113;113;126;112;114;113;113 00:13:49 INFO - PROCESS | 17207 | |1;audio-beat-detection;153;128;153;172;129;150;159;129;168;129 00:13:49 INFO - PROCESS | 17207 | |2;audio-dft;166;163;164;163;163;161;161;166;165;162 00:13:49 INFO - PROCESS | 17207 | |3;audio-fft;74;77;74;73;74;73;136;76;73;72 00:13:49 INFO - PROCESS | 17207 | |4;audio-oscillator;97;96;146;96;96;97;151;97;97;142 00:13:49 INFO - PROCESS | 17207 | |5;imaging-gaussian-blur;110;110;110;111;110;110;109;110;111;109 00:13:49 INFO - PROCESS | 17207 | |6;imaging-darkroom;147;147;148;146;146;147;146;146;147;146 00:13:49 INFO - PROCESS | 17207 | |7;imaging-desaturate;97;96;97;98;98;97;98;96;96;97 00:13:49 INFO - PROCESS | 17207 | |8;json-parse-financial;59;61;62;60;60;60;66;60;67;61 00:13:49 INFO - PROCESS | 17207 | |9;json-stringify-tinderbox;67;68;67;67;69;68;67;68;68;68 00:13:49 INFO - PROCESS | 17207 | |10;stanford-crypto-aes;90;83;91;84;82;85;84;83;82;91 00:13:49 INFO - PROCESS | 17207 | |11;stanford-crypto-ccm;116;117;117;122;131;122;118;122;114;125 00:13:49 INFO - PROCESS | 17207 | |12;stanford-crypto-pbkdf2;132;141;132;141;147;145;141;140;140;133 00:13:49 INFO - PROCESS | 17207 | |13;stanford-crypto-sha256-iterative;67;70;65;67;69;67;67;68;66;67 00:13:49 INFO - PROCESS | 17207 | __end_tp_report 00:13:49 INFO - PROCESS | 17207 | __start_cc_report 00:13:49 INFO - PROCESS | 17207 | _x_x_mozilla_cycle_collect,766 00:13:49 INFO - PROCESS | 17207 | __end_cc_report 00:13:49 INFO - PROCESS | 17207 | __startTimestamp1453450429262__endTimestamp 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | ------- Summary: start ------- 00:13:49 INFO - PROCESS | 17207 | Number of tests: 14 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:4.33 (3.8%) stddev-sans-first:4.58 00:13:49 INFO - PROCESS | 17207 | Values: 113.0 110.0 114.0 113.0 113.0 126.0 112.0 114.0 113.0 113.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:153.00 stddev:17.07 (11.2%) stddev-sans-first:17.97 00:13:49 INFO - PROCESS | 17207 | Values: 153.0 128.0 153.0 172.0 129.0 150.0 159.0 129.0 168.0 129.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.84 (1.1%) stddev-sans-first:1.69 00:13:49 INFO - PROCESS | 17207 | Values: 166.0 163.0 164.0 163.0 163.0 161.0 161.0 166.0 165.0 162.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:19.66 (26.6%) stddev-sans-first:20.73 00:13:49 INFO - PROCESS | 17207 | Values: 74.0 77.0 74.0 73.0 74.0 73.0 136.0 76.0 73.0 72.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:96.50 stddev:24.14 (25.0%) stddev-sans-first:25.02 00:13:49 INFO - PROCESS | 17207 | Values: 97.0 96.0 146.0 96.0 96.0 97.0 151.0 97.0 97.0 142.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 00:13:49 INFO - PROCESS | 17207 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 111.0 109.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:13:49 INFO - PROCESS | 17207 | Values: 147.0 147.0 148.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 00:13:49 INFO - PROCESS | 17207 | Values: 97.0 96.0 97.0 98.0 98.0 97.0 98.0 96.0 96.0 97.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.00 stddev:2.72 (4.5%) stddev-sans-first:2.71 00:13:49 INFO - PROCESS | 17207 | Values: 59.0 61.0 62.0 60.0 60.0 60.0 66.0 60.0 67.0 61.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 00:13:49 INFO - PROCESS | 17207 | Values: 67.0 68.0 67.0 67.0 69.0 68.0 67.0 68.0 68.0 68.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:3.69 (4.4%) stddev-sans-first:3.54 00:13:49 INFO - PROCESS | 17207 | Values: 90.0 83.0 91.0 84.0 82.0 85.0 84.0 83.0 82.0 91.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:122.00 stddev:5.06 (4.1%) stddev-sans-first:5.11 00:13:49 INFO - PROCESS | 17207 | Values: 116.0 117.0 117.0 122.0 131.0 122.0 118.0 122.0 114.0 125.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:141.00 stddev:5.25 (3.7%) stddev-sans-first:4.87 00:13:49 INFO - PROCESS | 17207 | Values: 132.0 141.0 132.0 141.0 147.0 145.0 141.0 140.0 140.0 133.0 00:13:49 INFO - PROCESS | 17207 | 00:13:49 INFO - PROCESS | 17207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 00:13:49 INFO - PROCESS | 17207 | Values: 67.0 70.0 65.0 67.0 69.0 67.0 67.0 68.0 66.0 67.0 00:13:49 INFO - PROCESS | 17207 | -------- Summary: end -------- 00:13:49 INFO - PROCESS | 17207 | 00:13:50 INFO - TEST-INFO | 17207: exit 0 00:13:50 INFO - TEST-OK | kraken | took 59986ms 00:13:50 INFO - TEST-START | v8_7 00:13:50 INFO - operating with platform_type : linux_ 00:13:50 INFO - Initialising browser for v8_7 test... 00:13:50 INFO - TEST-INFO | started process 17494 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kU4Xd/profile http://localhost:54553/getInfo.html) 00:13:53 INFO - PROCESS | 17494 | 00:13:53 INFO - PROCESS | 17494 | (process:17567): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:13:54 INFO - PROCESS | 17494 | __metrics Screen width/height:1600/1200 00:13:54 INFO - PROCESS | 17494 | colorDepth:24 00:13:54 INFO - PROCESS | 17494 | Browser inner width/height: 1024/697 00:13:54 INFO - PROCESS | 17494 | __metrics 00:13:54 INFO - PROCESS | 17494 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:13:55 INFO - TEST-INFO | 17494: exit 0 00:13:55 INFO - Browser initialized. 00:13:55 INFO - Running cycle 1/1 for v8_7 test... 00:13:55 INFO - TEST-INFO | started process 17616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kU4Xd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:13:56 INFO - PROCESS | 17616 | 00:13:56 INFO - PROCESS | 17616 | (process:17673): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:14:07 INFO - PROCESS | 17616 | RSS: Main: 153505792 00:14:07 INFO - PROCESS | 17616 | 00:14:29 INFO - PROCESS | 17616 | Cycle 1(1): loaded http://localhost:54553/tests/v8_7/run.html (next: http://localhost:54553/tests/v8_7/run.html) 00:14:30 INFO - PROCESS | 17616 | RSS: Main: 153919488 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | __start_tp_report 00:14:30 INFO - PROCESS | 17616 | _x_x_mozilla_page_load 00:14:30 INFO - PROCESS | 17616 | _x_x_mozilla_page_load_details 00:14:30 INFO - PROCESS | 17616 | |i|pagename|runs| 00:14:30 INFO - PROCESS | 17616 | |0;Richards;166.22340425531914 00:14:30 INFO - PROCESS | 17616 | |1;DeltaBlue;188.5014137606032 00:14:30 INFO - PROCESS | 17616 | |2;Encrypt;280.0336040324839 00:14:30 INFO - PROCESS | 17616 | |3;Decrypt;5223.958333333333 00:14:30 INFO - PROCESS | 17616 | |4;RayTrace;1078.7486515641856 00:14:30 INFO - PROCESS | 17616 | |5;Earley;691.5629322268327 00:14:30 INFO - PROCESS | 17616 | |6;Boyer;12382.716049382716 00:14:30 INFO - PROCESS | 17616 | |7;RegExp;40920 00:14:30 INFO - PROCESS | 17616 | |8;Splay;607.7481840193705 00:14:30 INFO - PROCESS | 17616 | |9;NavierStokes;4817.307692307692 00:14:30 INFO - PROCESS | 17616 | __end_tp_report 00:14:30 INFO - PROCESS | 17616 | __startTimestamp1453450470112__endTimestamp 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | ------- Summary: start ------- 00:14:30 INFO - PROCESS | 17616 | Number of tests: 10 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 166.2 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 188.5 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 280.0 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 5224.0 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 1078.7 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#5] Earley Cycles:1 Average:691.56 Median:691.56 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 691.6 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 12382.7 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#7] RegExp Cycles:1 Average:40920.00 Median:40920.00 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 40920.0 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#8] Splay Cycles:1 Average:607.75 Median:607.75 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 607.7 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - PROCESS | 17616 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 00:14:30 INFO - PROCESS | 17616 | Values: 4817.3 00:14:30 INFO - PROCESS | 17616 | -------- Summary: end -------- 00:14:30 INFO - PROCESS | 17616 | 00:14:30 INFO - TEST-INFO | 17616: exit 0 00:14:30 INFO - TEST-OK | v8_7 | took 40760ms 00:14:30 INFO - SUITE-END | took 1211s 00:14:31 INFO - Completed test suite (00:20:11) 00:14:31 INFO - Working with test: dromaeo_css 00:14:31 INFO - Generating results file: dromaeo_css 00:14:31 INFO - Working with test: kraken 00:14:31 INFO - Generating results file: kraken 00:14:31 INFO - javascript benchmark 00:14:31 INFO - Working with test: v8_7 00:14:31 INFO - Generating results file: v8_7 00:14:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:14:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 00:14:31 INFO - process_Request line: dromaeo_css 6713.22 graph.html#tests=[[72,1,43]] 00:14:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:14:31 INFO - process_Request line: kraken 1511.50 graph.html#tests=[[232,1,43]] 00:14:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:14:31 INFO - process_Request line: v8_7 20397.58 graph.html#tests=[[230,1,43]] 00:14:31 INFO - RETURN: dromaeo_css: 6713.22 00:14:31 INFO - RETURN: kraken: 1511.50 00:14:31 INFO - RETURN: v8_7: 20397.58 00:14:31 INFO - javascript benchmark 00:14:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.374561960418, 3216.6944140306678, 3221.114193596762, 3246.366958443103, 3252.967470325296, 5191.480851914806, 5219.295395121658, 5291.047611429941, 5306.442823503535, 5328.573714102872, 5287.894242115165, 5303.28405665236, 5304.098303288441, 5304.257403963448, 5336.9733151334285, 4822.758862056892, 4840.87897802556, 4850.07848508784, 4913.606911447094, 4926.9753651231695, 4912.926306105412, 4939.456659767423, 4939.827106051289, 4942.085714142877, 4944.035912996967, 4824.059308434857, 4916.164252077156, 4919.065377578267, 4920.630952678545, 4927.236278376839, 4698.107359601665, 4751.833685821014, 4754.7147171169845, 4845.3216549683075, 4904.0437114762635, 4807.42310922688, 4812.7352995585225, 4816.8795780105775, 4819.831305904277, 4854.805807767685, 5023.572996295319, 5124.128898087334, 5152.124138896396, 5161.561267292284, 5182.352205974254, 5605.663660180361, 5648.265725455664, 5648.604597678164, 5707.086866101404, 5744.080947048452, 5782.9421705782825, 5796.797112101099, 5799.536037117021, 5801.88396232073, 5804.448577385184, 5202.0, 5282.973585132127, 5404.810831620914, 5408.188771684239, 5432.91850622241, 5757.625754325955, 5799.594028417971, 5803.506701930383, 5837.591368604242, 5856.0, 5567.638103523258, 5617.9719101404235, 5624.71876406178, 5626.521745651584, 5635.9436405635415, 5624.606277560613, 5682.886342273131, 5707.914381284284, 5729.083346664514, 5739.426057394227, 5617.719114044281, 5659.094544872883, 5660.95272374612, 5682.261306030189, 5708.229389032511, 5556.166575013699, 5628.324601047901, 5678.176664383641, 5713.114467257582, 5720.0, 4341.522432532419, 4391.077873646506, 4397.494288156903, 4452.0, 4501.369808226851, 3959.089409435788, 3971.0667993021616, 3996.9400458993136, 4003.3594624859884, 4022.1151346703678, 5413.675179489164, 5433.673979561239, 5435.293411856513, 5450.345958485007, 5492.505674489315, 5592.664440133605, 5689.886202275931, 5694.829155125353, 5772.336181339116, 5836.824895253149, 5336.332958380202, 5384.434634363413, 5409.134538473904, 5419.864503387368, 5427.48438898304, 4898.53463920927, 4926.433460152057, 4942.654014219042, 4956.553910148032, 4999.525045120708, 5760.423957604206, 5801.477866991991, 5901.527877769769, 5929.822105336847, 6002.159697642333, 5731.226284451545, 5732.312122545154, 5757.280339957505, 5779.104238842986, 5780.653160810365, 5764.682942438206, 5931.051031835058, 5969.224000879858, 5981.371955944737, 5986.640801551921, 5609.354924183771, 5627.324721033502, 5643.830685079454, 5661.85845353853, 5667.546596272371, 5646.689432081275, 5650.378458369658, 5678.602497825278, 5684.7157642118555, 5693.146028095819, 5506.889862202814, 5563.026470367588, 5570.554355651457, 5575.609707320448, 5579.637323573955, 5479.0959491683425, 5520.585956053393, 5578.553715702815, 5592.692401917933, 5641.182028605911, 5496.7526461308535, 5499.642523235977, 5500.697461639648, 5501.001854549562, 5512.6692398456225, 5645.1532270159805, 5657.462541058593, 5659.434056594308, 5667.093265077733, 5685.374608792947, 5339.519443250126, 5365.2220428036935, 5454.318210223722, 5505.779768809202, 5557.610967232255], "unit": "score", "name": "dojo.html", "value": 5267.587614351612}, {"lowerIsBetter": false, "replicates": [518.1321286844537, 520.9531142197202, 540.354276639416, 540.4298465119299, 549.2393035645634, 35841.0, 36744.26511469769, 36909.0, 36980.26039479209, 37122.628773712255, 39627.20745585087, 39776.20447591046, 40078.59921400785, 40168.598314016854, 40206.79379618616, 8379.832403351915, 8499.532525711084, 8627.137286271385, 8665.740027799176, 8720.30237580992, 8316.126806685272, 8478.025027121867, 8518.105598912118, 8523.701670441536, 8532.70135545256, 8563.614637341303, 8797.516136612483, 8807.559622018873, 8808.427452215617, 8820.691275805348, 8683.13168683133, 8731.60707768152, 8779.78050548735, 8781.473111613292, 8797.164269394398, 8559.358048146414, 8698.304135669132, 8713.564321783886, 8730.781730456789, 8739.825203495959, 38919.61080389217, 39602.60397396047, 39614.60385396167, 39705.40441893374, 39720.80139599313, 3091.3199096199023, 3421.0250078727445, 3448.741344399155, 3512.824358782076, 3565.607783143852, 29663.25841853949, 29784.70215297841, 29824.8508757457, 30026.399472010657, 30935.690643093505, 3733.085394078468, 3768.924621507582, 3809.4095415210686, 3816.713746468998, 3852.5184351956004, 252045.99999999817, 253055.0, 253517.0, 254614.0, 255188.7240563804, 41268.38097428541, 41636.37545436821, 41951.58048419538, 42157.367639485434, 42158.57841421608, 40424.59575404267, 40511.797441013194, 40607.593924060384, 40858.59141408548, 40912.38631420531, 13076.476940922257, 13081.672958175932, 13214.735705286033, 13217.471301148038, 13248.536301229411, 11229.606963756229, 11245.15661325404, 11293.265937714023, 11297.152713546517, 11320.207585468937, 14528.418863245563, 14612.342444590018, 14643.853561464462, 14688.118712877262, 14688.19214943167, 5740.54075673945, 5809.7095145242565, 5818.563607729353, 5890.558208134321, 5953.851153721192, 903.5482258870564, 916.1159481100636, 1002.684154491333, 1006.3659894266711, 1083.06315037492, 28476.288092797433, 32532.83733581317, 32929.67070329314, 33236.1690957728, 33799.0, 996.461910568285, 1024.2267088348249, 1055.7835643693024, 1090.0, 1131.2929419113054, 14573.417063317349, 14591.78112328316, 14594.927025364805, 14598.0, 16399.0, 279847.0, 284015.0, 284847.0, 285861.0, 286202.0, 50651.49348506542, 52021.47978520166, 52055.73972130115, 52066.21900671493, 52273.7386313066, 1260.703734622363, 1261.0479088288284, 1292.2375798278872, 1318.4330737782846, 1333.2067419885152, 28098.438031239668, 29269.0, 30213.0, 30994.22514437067, 31383.372332552764, 44765.77617111894, 45126.54873451223, 45216.0, 45583.0, 45623.31565026461, 294819.0, 294981.0, 294998.0, 295746.0, 296608.0, 41484.37773433341, 41767.791161044, 42076.78961605173, 42449.36325955175, 42580.78709606432, 39386.40920386254, 40502.79748601238, 40876.59123408728, 42662.78668606637, 43379.566204338815, 35397.82301088478, 35585.0, 35968.64031359758, 36956.44565331576, 37144.442833358065, 36080.45879311865, 36413.817930910176, 36487.81756091202, 36666.45000325051, 36875.63124368722, 37798.62201377951, 37824.243515130096, 38576.614233857304, 38898.0, 39129.0, 28993.0, 29310.26724331909, 31566.526502102945, 31622.525662114625, 31679.84160079185, 23499.412514686584, 24749.62875556832, 26295.868520657274, 27628.861855691397, 28154.85922570374], "unit": "score", "name": "ext.html", "value": 17712.21321762992}, {"lowerIsBetter": false, "replicates": [349.12195827493855, 353.1154458082504, 353.3604176440643, 353.90090774583126, 354.19597513644027, 15433.69132617347, 15773.684526309482, 16652.75020874688, 16878.409255676055, 17569.91215043923, 15530.0, 15850.445234416798, 16126.435574754885, 16620.25208865601, 16731.665366692658, 4797.784099715513, 4959.181735013718, 4978.452370239289, 4980.003999200157, 4980.477049909761, 4814.109389762888, 4901.975490122562, 4925.38432695913, 5432.83701488954, 5456.536194423479, 5103.055934652083, 5289.497497737709, 5290.1800220965815, 5421.972890135544, 5460.781568737246, 5230.895382092356, 5257.158854583267, 5261.710605916654, 5629.380768115545, 6074.210352654127, 5425.050616142199, 5428.864278393033, 5430.266913966603, 5459.2902922619805, 5481.561475081984, 12270.81593776094, 12547.24716517012, 12754.234745915182, 12805.807912881315, 12821.743565128645, 2033.5729496805689, 2050.0877109686194, 2084.937451876446, 2143.9142434302607, 2225.0209907640588, 8941.016488186295, 9132.36073474857, 9202.53987300639, 9292.674756383494, 10767.6231331903, 1718.5445856847946, 1734.8785585009055, 1762.2422358385888, 1820.963580728378, 1837.4855040588657, 54718.452815472134, 55634.0, 55680.44319556834, 55701.44298557003, 55724.0, 10370.948145259226, 10376.636817711344, 10404.479776011169, 10405.115565177044, 10481.580736770444, 13417.396217170251, 13442.260675662932, 13549.864501355058, 13621.387037583332, 13626.250556219306, 7212.963935180395, 7289.4168466523615, 7333.1933487316355, 7336.229695881855, 7361.1166660001145, 6800.183977922681, 7005.789826305219, 7025.0, 7067.540609860343, 7074.469414793911, 4425.668074894395, 4474.149911516802, 4514.210013247669, 4537.500874903758, 4539.727616342964, 1779.5195297269665, 1818.4544636608964, 1857.8792378495355, 1885.8585606079598, 1892.858035647332, 408.4547129581982, 788.4480863395646, 853.9146085391535, 917.9862302065341, 958.152035448619, 10223.386596804216, 10672.30630009047, 10803.351798891934, 10948.781024379468, 11049.944750276198, 436.312807328459, 452.64693539039604, 453.7459022947094, 460.9285560738091, 479.27150730888854, 5592.720363981784, 5774.191613174159, 5783.2192653992015, 5886.735096920649, 5903.490504614746, 465422.0, 474611.0, 497464.0, 512224.0, 513784.0, 45371.54628453739, 69955.0, 72332.63833680798, 72998.0, 73430.0, 1090.334895713614, 1111.777644471109, 1123.6067376418189, 1125.7129431994788, 1159.9710007249716, 13764.518241861486, 14191.503297384543, 14525.782113268098, 14805.629859253175, 14904.925475372555, 29279.707202928552, 29661.0, 30582.0, 30640.387192255585, 30705.846470767505, 33009.66990330066, 33781.493277601345, 34292.314153717285, 35034.474482883285, 36087.0, 6760.932390676227, 6871.381575658214, 7045.26024767392, 7286.198518162892, 7345.118585769528, 8610.78473038179, 10269.0, 10500.684979450629, 10567.0, 10808.405537695502, 8662.350323725872, 9083.863742043743, 9487.810243794947, 9859.605615775288, 10077.748056298651, 9147.496887670975, 9962.0, 9983.301168918106, 10013.14888234479, 10203.336783109075, 9618.326717129734, 9698.933117357226, 9793.608255669978, 9985.1512621428, 10095.596176152872, 6671.132752742306, 6785.93214067853, 7155.964220178866, 7204.891926621, 7264.346208841018, 8100.554469504234, 9478.526073696425, 9555.123798136856, 9737.805243895224, 9842.901570984484], "unit": "score", "name": "jquery.html", "value": 7487.360055887066}, {"lowerIsBetter": false, "replicates": [1233.3093467658116, 1239.5847391123973, 1275.929823859688, 1427.143713771737, 1432.1478720161513, 7366.889496657554, 7428.4428667849925, 7582.241775822415, 7654.846903061935, 7663.157052724196, 7585.279398457152, 7604.391648668107, 7615.5811430371305, 7652.502587331819, 7654.502457340269, 2292.4383526036145, 2293.8738369389675, 2293.919712810052, 2300.9884950575224, 2312.8034117100065, 2202.0971401725296, 2238.50752834377, 2250.7861753133425, 2251.34710933829, 2264.841461097724, 2242.1816037146405, 2276.9544609107807, 2295.9426014349606, 2320.5706944215376, 2320.825938054644, 2237.9552408951813, 2240.0, 2254.7068881045443, 2268.7958083772373, 2271.534335461243, 2235.944101397462, 2256.5035692147867, 2263.694401255826, 2264.30938563738, 2264.4225722440674, 7437.0, 7455.925440745577, 7487.363574096208, 7505.924940750577, 7523.3229009389415, 4508.932366014513, 4616.076784643051, 4629.0279041401345, 4643.3963584733765, 4676.7427791471455, 2916.1543152485756, 2957.852107394643, 2973.9851300743358, 2985.4924662807157, 2986.4325778102093, 945.2343601682659, 963.2775418436173, 970.898055704155, 981.8772653418323, 991.2912267728609, 10071.093601575893, 10170.084692377648, 10195.337303075275, 10226.53980570876, 10241.692749217535, 4051.716379853441, 4057.756534607933, 4084.7344922579937, 4086.223617512663, 4255.893602659897, 8220.958895205606, 8280.337572994145, 8330.375221858385, 8333.791655208546, 8338.499690018618, 4655.068986202706, 4681.368015317888, 4700.694454860423, 4709.105269998689, 4736.3369128322065, 4310.482742070972, 4340.240457919915, 4341.044970106572, 4346.826126954949, 4355.542668019875, 3480.112571294304, 3484.094135524782, 3509.8771542996383, 3519.7008254298157, 3538.0, 1043.400044974143, 1050.1336397472116, 1053.0, 1055.4300677634146, 1058.2010582010687, 944.2398868910456, 949.1457688080783, 985.3693636072919, 992.9056739609725, 1159.2059439284117, 7006.124234470692, 7070.292970702889, 7097.112860892388, 7113.857722845514, 7170.1754298256365, 1088.7169335972703, 1106.4744246482855, 1125.426032723317, 1126.9605563805228, 1137.5392965848844, 4917.409910810726, 4919.114559379346, 4947.5794557462295, 4948.134076536664, 4994.126027945095, 8932.151445612657, 8946.821063578693, 9214.815703685888, 9341.0, 9407.247420206504, 9115.635374585076, 9198.862017069749, 9209.263258939269, 9248.121428464285, 9257.537123143817, 6809.285025072296, 6992.300769922967, 6997.47518936092, 7228.96385518069, 7407.333339999426, 7128.073350464614, 7162.964185179041, 7179.210286868545, 7201.603911784692, 7202.603856787927, 7967.880481792662, 8310.792230194293, 8409.789755256168, 8426.789330266793, 8573.485590864568, 7727.0, 7830.804229894298, 7872.409569282212, 7894.921050789419, 7903.209679032051, 6194.132821404917, 6345.397187267202, 6620.602763834186, 6653.800385988428, 6676.399124078856, 6918.515703900679, 6919.238883722887, 6920.896186557105, 6937.236903940461, 6941.167059952838, 6531.640759758259, 6624.0, 6700.061991321317, 6764.2221144569, 6806.863862722619, 6479.352064793483, 6488.480921526361, 6632.137822083098, 6649.867002659823, 6702.128723265944, 6306.46395056407, 6311.116443697794, 6543.214814222324, 6566.507511936528, 6569.113169722217, 6135.785247516315, 6196.411340922605, 6213.689315534115, 6241.78153764616, 6243.687815609293, 6198.101275315144, 6309.526785491014, 6319.115323854572, 6376.234851817626, 6394.360563943755], "unit": "score", "name": "mootools.html", "value": 4303.905511309314}, {"lowerIsBetter": false, "replicates": [334.2729563200039, 334.7271973341726, 343.29452974138144, 344.63985135533363, 346.50622862421045, 6133.049377346519, 6260.749570017194, 6325.082862984865, 6328.715207815648, 6337.239531256244, 6081.209442772444, 6238.4697300729495, 6257.749690012405, 6259.280182778971, 6282.434580887719, 4801.207800712878, 4803.663743537953, 4805.399325084364, 4806.471288158317, 4806.807727690888, 4816.253480710478, 4816.349792777983, 4819.542143496362, 4822.782974766126, 4831.9275210871865, 4690.179218636742, 4780.521947805227, 4797.472278049412, 4798.304245884362, 4800.279958006309, 4753.90492190156, 4764.2615394613895, 4772.976135119319, 4773.307870358796, 4781.737004464753, 3928.391099379572, 4067.145899361108, 4219.894502637428, 4223.831046758126, 4224.324108142713, 5827.300723913115, 5896.7936122235515, 5960.403959604048, 5992.191054207669, 6007.0, 5553.4172760763395, 5572.164175373686, 5575.804846830341, 5584.301962254718, 5603.851210501837, 6485.448736857373, 6672.699728512229, 6680.1983761948395, 6680.632565208912, 6690.464762818963, 4679.087577922306, 4679.60223381013, 4685.250359942427, 4688.929666055012, 4694.624430045622, 6917.688704008332, 6967.6167810770385, 6982.0, 6985.89521157183, 6991.265917078685, 4766.070616229802, 4813.831515896997, 4815.277708343707, 4823.1800593899125, 4825.469198388175, 4606.884827879263, 4739.928901066487, 4744.383230180055, 4882.487338829443, 4883.218685010453, 5500.147477141049, 5550.888982220333, 5555.500004999489, 5559.861003474864, 5577.135543990688, 6706.061151438803, 6713.765018224436, 6720.193576770819, 6742.932570674328, 6761.0872532208505, 1655.1806855606312, 1696.4571337171988, 1699.6402877697792, 1701.3534856754354, 1703.2931333496708, 1085.8968398002178, 1111.6776134920783, 1112.477135746198, 1123.6514688156885, 1125.386664267976, 6299.559030867796, 6302.905456418157, 6311.652859092702, 6320.367963203735, 6339.270983836917, 6796.8300792479595, 6802.047713320139, 6807.931920680829, 6821.727130914708, 6848.760293389708, 6177.289611694623, 6200.56596038282, 6243.532769799093, 6245.75016999324, 6258.499320054385, 3674.430463278196, 3683.1712864605784, 3748.55017397914, 3767.7362584619364, 3771.2834561433788, 7138.928610713826, 7271.163816161104, 7306.561606303639, 7319.597422141726, 7330.230325815819, 7058.329458701415, 7084.185318688416, 7113.53762005468, 7127.89308160378, 7136.393406560397, 7134.607596582134, 7250.948612451165, 7279.563226206445, 7284.781456556206, 7300.707971681286, 7023.789286321418, 7071.7878463646175, 7078.256783037707, 7078.858422831411, 7080.929190708027, 6827.6244806536115, 6845.486588505982, 6876.656167191721, 6878.828029299308, 6915.585064896122, 7070.540414873017, 7231.385332246818, 7251.746188883364, 7302.3792977597495, 7303.269673032654, 4633.976830115827, 4634.698744581591, 4656.8137274508645, 4665.743384113906, 4671.556202160789, 6902.482313826584, 6920.826979325557, 6960.512764106464, 6986.790396288119, 6997.895031574429, 6613.603183808987, 6744.730210791513, 6761.290064543349, 6781.89827152603, 6790.93209067903, 6699.062131301719, 6745.089412929388, 6761.797146085625, 6768.0, 6772.52592318533, 6549.803505894831, 6567.44176744982, 6576.243731970884, 6616.503762217757, 6617.305182955721, 6636.104125942936, 6751.831204219934, 6791.524593278423, 6819.147606549182, 6820.761273355409, 6589.17635295588, 6598.274189839018, 6654.3012983637955, 6657.101291325609, 6658.766943156967], "unit": "score", "name": "prototype.html", "value": 5038.779290467511}, {"lowerIsBetter": false, "replicates": [772.0276933804848, 822.296936119618, 830.1490971753951, 830.8130670599114, 832.8417600655879, 12033.51865925363, 12147.028237740982, 12152.513899444033, 12157.331346775924, 12218.877811221884, 11710.707232319175, 11716.355600441972, 11728.706782330446, 11745.354005529693, 11777.05783537317, 779.364817673597, 799.2087833045273, 800.1758189065272, 802.0215337288498, 802.1377019703842, 550.2379204801339, 564.5793883556756, 566.8214512428572, 568.9004424225765, 794.6860989908982, 838.0153319849184, 838.5639467476908, 838.7022606974527, 840.8948881389827, 841.6002398860553, 828.6146941672122, 830.1739768929954, 830.3025458614793, 833.0669649992018, 837.1921096142252, 605.8485378655337, 608.856918624123, 609.6464050850541, 610.1823556434355, 615.1910238036967, 11988.100892433102, 12041.518339266418, 12095.818562721566, 12124.090693197957, 12135.361726166942, 11823.994960428374, 11966.700832479257, 11975.88024119765, 12183.0, 12391.566295179626, 9754.561044753003, 9830.655927042591, 10018.098371146632, 10344.5344959477, 10526.578936842594, 3407.4037043517533, 3462.9480557791653, 3504.1489959380083, 3518.894433167009, 3626.202235508184, 47099.76450117728, 47388.76305618484, 47516.0, 47590.28614570784, 47753.761231193625, 9669.90330096704, 9822.312438129406, 9859.26055545837, 9878.851817222747, 10123.696289111338, 17745.290188392577, 17813.554661133574, 17862.55343616394, 17868.285268589112, 17876.55308617295, 7458.776236712907, 7524.021877155935, 7524.811879703051, 7580.924190758132, 7743.728969486041, 4104.445899803488, 4136.73111247768, 4152.190322887069, 4254.595813397722, 4448.154850578379, 2931.560265960123, 2961.08206455995, 2964.777641676883, 2964.836933968609, 2968.09473110699, 579.2701196492366, 585.4672248254068, 586.2847326261954, 601.8886505996404, 605.3129697793037, 513.3531749995033, 561.8342588936192, 566.2157911292888, 585.0843430032071, 635.3646353646353, 7796.961015195001, 7936.642851071716, 8056.919430805734, 8071.192880711882, 8245.299149572234, 591.4647244243966, 616.5529990756665, 621.8973869311603, 635.8124353315783, 638.5211091681239, 3966.0, 4047.1298670785923, 4180.163967206571, 4195.4336164618, 4252.340887162495, 53115.46884531183, 53884.0, 54154.729226353615, 54162.0, 55235.44764552303, 48219.0, 48244.0, 48267.5173248263, 48305.27542086872, 49016.50983490191, 43452.78273608612, 43788.12423751571, 44559.33161002523, 44602.55397445984, 44885.55114448879, 8680.78298042554, 8795.824083518422, 8858.867116993122, 8860.379773416056, 8937.910620893708, 32713.836430817693, 32807.50788738123, 32960.505592415655, 33407.33185336231, 33979.32041359109, 40487.392689109096, 42498.0, 42608.0, 42808.357874631285, 43075.353869692604, 10266.127379172854, 11076.446177690923, 11172.776544469227, 11432.714182145513, 11450.08399328035, 11905.107116966436, 11976.820347694966, 12063.155579109378, 12709.872901270868, 12754.42605082755, 10285.691429256834, 10702.83945740799, 11367.54529818798, 11467.31196128235, 11843.348615826213, 10325.535350909076, 10529.42088185157, 10612.310199836986, 10645.627403040857, 10684.198685098494, 9704.466254356079, 10291.176705863363, 10335.121514671337, 10378.06597406237, 10527.052565268856, 8809.779755506164, 9098.772530686785, 9182.127697868691, 9191.586378613112, 9296.72109836706, 8555.0, 8755.51844648525, 8821.955890220508, 9266.258699303904, 9337.346385752931], "unit": "score", "name": "yui.html", "value": 6041.563777433055}], "name": "dromaeo_css", "value": 6713.223233381243}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 113.0, 113.0, 126.0, 112.0, 114.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 153.0, 172.0, 129.0, 150.0, 159.0, 129.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [166.0, 163.0, 164.0, 163.0, 163.0, 161.0, 161.0, 166.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 74.0, 73.0, 74.0, 73.0, 136.0, 76.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 146.0, 96.0, 96.0, 97.0, 151.0, 97.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 98.0, 98.0, 97.0, 98.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 62.0, 60.0, 60.0, 60.0, 66.0, 60.0, 67.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 91.0, 84.0, 82.0, 85.0, 84.0, 83.0, 82.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 122.0, 131.0, 122.0, 118.0, 122.0, 114.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [132.0, 141.0, 132.0, 141.0, 147.0, 145.0, 141.0, 140.0, 140.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 65.0, 67.0, 69.0, 67.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1511.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [691.5629322268327], "unit": "score", "name": "Earley", "value": 963.7054980000003}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [40920.0], "unit": "score", "name": "RegExp", "value": 22.26258553274684}, {"lowerIsBetter": false, "replicates": [607.7481840193705], "unit": "score", "name": "Splay", "value": 134.08678486055774}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20397.57969025715}]} 00:14:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20397.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1511.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6713.22"}}} 00:14:31 INFO - Return code: 0 00:14:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:14:31 INFO - # TBPL SUCCESS # 00:14:31 INFO - Running post-action listener: _resource_record_post_action 00:14:31 INFO - Running post-run listener: _resource_record_post_run 00:14:32 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 548597760; Read time: 0; Write time: 861172 00:14:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 236146688; Read time: 0; Write time: 469068 00:14:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 312451072; Read time: 0; Write time: 392104 00:14:32 INFO - Running post-run listener: _upload_blobber_files 00:14:32 INFO - Blob upload gear active. 00:14:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 00:14:32 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 00:14:32 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 00:14:32 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 00:14:32 INFO - (blobuploader) - INFO - Open directory for files ... 00:14:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:14:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:14:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:14:33 INFO - (blobuploader) - INFO - Done attempting. 00:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:14:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:14:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:14:34 INFO - (blobuploader) - INFO - Done attempting. 00:14:34 INFO - (blobuploader) - INFO - Iteration through files over. 00:14:34 INFO - Return code: 0 00:14:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 00:14:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 00:14:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f14adff540ed91be33d6fee6c22ed00826a0fd3704337a2338b4a3823307a92513138f09db34fe92e8b7b33d58fadde1eb1ff31e071e88afdeaf33febebe836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2d9fa532019e6ee0f04c7e150a5a356e039c70ef2c1bc8eda6822581b6210339b91d50ff699321ec26119503f89f9ad3610dcdc6de16b0fb1062629f104b2a"} 00:14:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 00:14:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 00:14:34 INFO - Contents: 00:14:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f14adff540ed91be33d6fee6c22ed00826a0fd3704337a2338b4a3823307a92513138f09db34fe92e8b7b33d58fadde1eb1ff31e071e88afdeaf33febebe836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2d9fa532019e6ee0f04c7e150a5a356e039c70ef2c1bc8eda6822581b6210339b91d50ff699321ec26119503f89f9ad3610dcdc6de16b0fb1062629f104b2a"} 00:14:34 INFO - Running post-run listener: copy_logs_to_upload_dir 00:14:34 INFO - Copying logs to upload dir... 00:14:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 00:14:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.225828 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-22 00:14:34.086640) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 00:14:34.090377) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 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/Firefox/sha512/5f14adff540ed91be33d6fee6c22ed00826a0fd3704337a2338b4a3823307a92513138f09db34fe92e8b7b33d58fadde1eb1ff31e071e88afdeaf33febebe836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2d9fa532019e6ee0f04c7e150a5a356e039c70ef2c1bc8eda6822581b6210339b91d50ff699321ec26119503f89f9ad3610dcdc6de16b0fb1062629f104b2a"} build_url:https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/Xc1rnB5KQyC2l5fwJ3DL3w/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/Firefox/sha512/5f14adff540ed91be33d6fee6c22ed00826a0fd3704337a2338b4a3823307a92513138f09db34fe92e8b7b33d58fadde1eb1ff31e071e88afdeaf33febebe836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd2d9fa532019e6ee0f04c7e150a5a356e039c70ef2c1bc8eda6822581b6210339b91d50ff699321ec26119503f89f9ad3610dcdc6de16b0fb1062629f104b2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 00:14:34.118503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 00:14:34.119062) ========= 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=f919189b672bc2eeae365d21000001d6-1453448817.953542-1760298159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 00:14:34.203875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 00:14:34.204209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 00:14:34.204485) ========= ========= Total master_lag: 0.30 =========