builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1453828439.28 results: success (0) buildid: 20160126091107 builduid: 99081a66bfb54cd48cfb5122d5a3d909 revision: b9a803752a2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.285272) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.285772) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.286089) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005320 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.307584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.308073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.322996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.323303) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.374083) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.374372) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.374727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.374997) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 09:13:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-01-26 09:13:59 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.469867 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.858990) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.859495) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014995 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:13:59.910637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-26 09:13:59.911261) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9a803752a2c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9a803752a2c --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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 09:14:00,072 Setting DEBUG logging. 2016-01-26 09:14:00,072 attempt 1/10 2016-01-26 09:14:00,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9a803752a2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-26 09:14:01,187 unpacking tar archive at: mozilla-aurora-b9a803752a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.423547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-26 09:14:01.348450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:01.348809) ========= echo b9a803752a2c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b9a803752a2c'] 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b9a803752a2c program finished with exit code 0 elapsedTime=0.003953 script_repo_revision: 'b9a803752a2c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:01.398387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:01.398706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:01.408764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-26 09:14:01.409149) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:01 INFO - MultiFileLogger online at 20160126 09:14:01 in /builds/slave/test-pgo 09:14:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:14:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:14:01 INFO - {'append_to_log': False, 09:14:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:14:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:14:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:14:01 INFO - 'branch': 'Mozilla-Aurora', 09:14:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:01 INFO - 'config_files': ('talos/linux_config.py',), 09:14:01 INFO - 'default_actions': ('clobber', 09:14:01 INFO - 'read-buildbot-config', 09:14:01 INFO - 'download-and-extract', 09:14:01 INFO - 'populate-webroot', 09:14:01 INFO - 'create-virtualenv', 09:14:01 INFO - 'install', 09:14:01 INFO - 'run-tests'), 09:14:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:01 INFO - 'download_minidump_stackwalk': True, 09:14:01 INFO - 'download_symbols': 'ondemand', 09:14:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:01 INFO - 'installer_path': 'installer.exe', 09:14:01 INFO - 'log_level': 'info', 09:14:01 INFO - 'log_name': 'talos', 09:14:01 INFO - 'log_to_console': True, 09:14:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:01 INFO - 'opt_config_files': (), 09:14:01 INFO - 'pip_index': False, 09:14:01 INFO - 'sps_profile': False, 09:14:01 INFO - 'sps_profile_interval': 0, 09:14:01 INFO - 'suite': 'dromaeojs', 09:14:01 INFO - 'system_bits': '32', 09:14:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:01 INFO - 'title': 'talos-linux64-ix-055', 09:14:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:01 INFO - 'use_talos_json': True, 09:14:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:14:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:01 INFO - 'work_dir': 'build'} 09:14:01 INFO - ##### 09:14:01 INFO - ##### Running clobber step. 09:14:01 INFO - ##### 09:14:01 INFO - Running pre-action listener: _resource_record_pre_action 09:14:01 INFO - Running main action method: clobber 09:14:01 INFO - rmtree: /builds/slave/test-pgo/build 09:14:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - ##### 09:14:02 INFO - ##### Running read-buildbot-config step. 09:14:02 INFO - ##### 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: read_buildbot_config 09:14:02 INFO - Using buildbot properties: 09:14:02 INFO - { 09:14:02 INFO - "project": "", 09:14:02 INFO - "product": "firefox", 09:14:02 INFO - "script_repo_revision": "production", 09:14:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:14:02 INFO - "repository": "", 09:14:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:14:02 INFO - "buildid": "20160126091107", 09:14:02 INFO - "stage_platform": "linux64-pgo", 09:14:02 INFO - "basedir": "/builds/slave/test-pgo", 09:14:02 INFO - "buildnumber": 130, 09:14:02 INFO - "platform": "ubuntu64_hw", 09:14:02 INFO - "mozci_request": { 09:14:02 INFO - "priority": -1, 09:14:02 INFO - "type": "trigger_all_talos_jobs", 09:14:02 INFO - "times": 6 09:14:02 INFO - }, 09:14:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:14:02 INFO - "slavebuilddir": "test", 09:14:02 INFO - "branch": "mozilla-aurora", 09:14:02 INFO - "revision": "b9a803752a2c", 09:14:02 INFO - "slavename": "talos-linux64-ix-055", 09:14:02 INFO - "builduid": "99081a66bfb54cd48cfb5122d5a3d909", 09:14:02 INFO - "repo_path": "releases/mozilla-aurora" 09:14:02 INFO - } 09:14:02 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:14:02 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json. 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - ##### 09:14:02 INFO - ##### Running download-and-extract step. 09:14:02 INFO - ##### 09:14:02 INFO - Running pre-action listener: _resource_record_pre_action 09:14:02 INFO - Running main action method: download_and_extract 09:14:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:14:02 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')]} 09:14:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json 09:14:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:14:02 INFO - Downloaded 1448 bytes. 09:14:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:14:02 INFO - Using the following test package requirements: 09:14:02 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:02 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:02 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:14:02 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'jsshell-linux-x86_64.zip'], 09:14:02 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:02 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:02 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:14:02 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:14:02 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:02 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:02 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:02 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:02 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:02 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')]} 09:14:02 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:14:02 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:02 INFO - Downloaded 22398026 bytes. 09:14:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:14:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:14:03 INFO - Return code: 0 09:14:03 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:14:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:14:04 INFO - Downloaded 22398026 bytes. 09:14:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:14:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:14:05 INFO - Return code: 0 09:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:14:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:14:05 INFO - Downloaded 10706572 bytes. 09:14:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:14:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:14:06 INFO - Return code: 0 09:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:14:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:14:06 INFO - Downloaded 59570039 bytes. 09:14:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:14:06 INFO - mkdir: /builds/slave/test-pgo/properties 09:14:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:14:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:14:06 INFO - Contents: 09:14:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:14:06 INFO - Running post-action listener: _resource_record_post_action 09:14:06 INFO - Running post-action listener: set_extra_try_arguments 09:14:06 INFO - ##### 09:14:06 INFO - ##### Running populate-webroot step. 09:14:06 INFO - ##### 09:14:06 INFO - Running pre-action listener: _resource_record_pre_action 09:14:06 INFO - Running main action method: populate_webroot 09:14:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:06 INFO - '--tppagecycles', 09:14:06 INFO - '7'], 09:14:06 INFO - 'tests': ['tsvgm']}}, 09:14:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:14:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:14:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:14:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'tests': ['damp', 'tps']}, 09:14:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['damp', 'tps']}, 09:14:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:14:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:06 INFO - 'other': {'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'other_l64': {'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:14:06 INFO - 'ts_paint', 09:14:06 INFO - 'tpaint', 09:14:06 INFO - 'sessionrestore', 09:14:06 INFO - 'sessionrestore_no_auto_restore']}, 09:14:06 INFO - 'svgr': {'tests': ['tsvgx', 09:14:06 INFO - 'tsvgr_opacity', 09:14:06 INFO - 'tart', 09:14:06 INFO - 'tscrollx', 09:14:06 INFO - 'cart']}, 09:14:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['tsvgx', 09:14:06 INFO - 'tsvgr_opacity', 09:14:06 INFO - 'tart', 09:14:06 INFO - 'tscrollx', 09:14:06 INFO - 'cart']}, 09:14:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'tests': ['tp5o']}, 09:14:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'talos_options': ['--e10s'], 09:14:06 INFO - 'tests': ['tp5o']}, 09:14:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'talos_options': ['--xperf_path', 09:14:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:06 INFO - 'tests': ['tp5n']}, 09:14:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:06 INFO - 'talos_options': ['--e10s', 09:14:06 INFO - '--xperf_path', 09:14:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:06 INFO - 'tests': ['tp5n']}}, 09:14:06 INFO - 'talos.zip': {'path': '', 09:14:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:06 INFO - Running post-action listener: _resource_record_post_action 09:14:06 INFO - ##### 09:14:06 INFO - ##### Running create-virtualenv step. 09:14:06 INFO - ##### 09:14:06 INFO - Running pre-action listener: _resource_record_pre_action 09:14:06 INFO - Running main action method: create_virtualenv 09:14:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:14:06 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 09:14:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:14:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:07 INFO - Using real prefix '/usr' 09:14:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:14:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:09 INFO - Installing pip.................done. 09:14:09 INFO - Return code: 0 09:14:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:14:09 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')]} 09:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:09 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')]} 09:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:09 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:09 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 09:14:09 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 09:14:09 INFO - Using env: {'DISPLAY': ':0', 09:14:09 INFO - 'HOME': '/home/cltbld', 09:14:09 INFO - 'LANG': 'en_US.UTF-8', 09:14:09 INFO - 'LANGUAGE': 'en_US:en', 09:14:09 INFO - 'LOGNAME': 'cltbld', 09:14:09 INFO - 'MAIL': '/var/mail/cltbld', 09:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:09 INFO - 'MOZ_NO_REMOTE': '1', 09:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:09 INFO - 'NO_EM_RESTART': '1', 09:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:09 INFO - 'SHELL': '/bin/bash', 09:14:09 INFO - 'SHLVL': '1', 09:14:09 INFO - 'TERM': 'linux', 09:14:09 INFO - 'TMOUT': '86400', 09:14:09 INFO - 'USER': 'cltbld', 09:14:09 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:09 INFO - '_': '/tools/buildbot/bin/python'} 09:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:09 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 09:14:09 INFO - Cleaning up... 09:14:09 INFO - Return code: 0 09:14:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:14:09 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')]} 09:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:09 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')]} 09:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:09 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:09 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 09:14:09 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 09:14:09 INFO - Using env: {'DISPLAY': ':0', 09:14:09 INFO - 'HOME': '/home/cltbld', 09:14:09 INFO - 'LANG': 'en_US.UTF-8', 09:14:09 INFO - 'LANGUAGE': 'en_US:en', 09:14:09 INFO - 'LOGNAME': 'cltbld', 09:14:09 INFO - 'MAIL': '/var/mail/cltbld', 09:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:09 INFO - 'MOZ_NO_REMOTE': '1', 09:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:09 INFO - 'NO_EM_RESTART': '1', 09:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:09 INFO - 'SHELL': '/bin/bash', 09:14:09 INFO - 'SHLVL': '1', 09:14:09 INFO - 'TERM': 'linux', 09:14:09 INFO - 'TMOUT': '86400', 09:14:09 INFO - 'USER': 'cltbld', 09:14:09 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:09 INFO - '_': '/tools/buildbot/bin/python'} 09:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:09 INFO - Downloading/unpacking psutil>=0.7.1 09:14:09 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 09:14:09 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 09:14:09 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 09:14:09 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 09:14:09 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 09:14:09 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 09:14:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:11 INFO - Installing collected packages: psutil 09:14:11 INFO - Running setup.py install for psutil 09:14:11 INFO - building 'psutil._psutil_linux' extension 09:14:11 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 09:14:12 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 09:14:12 INFO - building 'psutil._psutil_posix' extension 09:14:12 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 09:14:12 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 09:14:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:12 INFO - Successfully installed psutil 09:14:12 INFO - Cleaning up... 09:14:12 INFO - Return code: 0 09:14:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:14:12 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')]} 09:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:12 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')]} 09:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:12 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:12 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 09:14:12 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 09:14:12 INFO - Using env: {'DISPLAY': ':0', 09:14:12 INFO - 'HOME': '/home/cltbld', 09:14:12 INFO - 'LANG': 'en_US.UTF-8', 09:14:12 INFO - 'LANGUAGE': 'en_US:en', 09:14:12 INFO - 'LOGNAME': 'cltbld', 09:14:12 INFO - 'MAIL': '/var/mail/cltbld', 09:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:12 INFO - 'MOZ_NO_REMOTE': '1', 09:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:12 INFO - 'NO_EM_RESTART': '1', 09:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:12 INFO - 'SHELL': '/bin/bash', 09:14:12 INFO - 'SHLVL': '1', 09:14:12 INFO - 'TERM': 'linux', 09:14:12 INFO - 'TMOUT': '86400', 09:14:12 INFO - 'USER': 'cltbld', 09:14:12 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:12 INFO - '_': '/tools/buildbot/bin/python'} 09:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:14:12 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 09:14:12 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 09:14:12 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 09:14:12 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 09:14:12 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 09:14:12 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 09:14:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:14:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:14:14 INFO - Installing collected packages: mozsystemmonitor 09:14:14 INFO - Running setup.py install for mozsystemmonitor 09:14:14 INFO - Successfully installed mozsystemmonitor 09:14:14 INFO - Cleaning up... 09:14:14 INFO - Return code: 0 09:14:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:14 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:14 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 09:14:14 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 09:14:14 INFO - Using env: {'DISPLAY': ':0', 09:14:14 INFO - 'HOME': '/home/cltbld', 09:14:14 INFO - 'LANG': 'en_US.UTF-8', 09:14:14 INFO - 'LANGUAGE': 'en_US:en', 09:14:14 INFO - 'LOGNAME': 'cltbld', 09:14:14 INFO - 'MAIL': '/var/mail/cltbld', 09:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:14 INFO - 'MOZ_NO_REMOTE': '1', 09:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:14 INFO - 'NO_EM_RESTART': '1', 09:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:14 INFO - 'SHELL': '/bin/bash', 09:14:14 INFO - 'SHLVL': '1', 09:14:14 INFO - 'TERM': 'linux', 09:14:14 INFO - 'TMOUT': '86400', 09:14:14 INFO - 'USER': 'cltbld', 09:14:14 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:14 INFO - '_': '/tools/buildbot/bin/python'} 09:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:14 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 09:14:14 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 09:14:14 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 09:14:14 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 09:14:14 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 09:14:14 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 09:14:16 INFO - Downloading blobuploader-1.2.4.tar.gz 09:14:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:14:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 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 09:14:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:14:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:14:17 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 09:14:17 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 09:14:17 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 09:14:17 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 09:14:17 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 09:14:17 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 09:14:17 INFO - Downloading docopt-0.6.1.tar.gz 09:14:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:14:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:14:17 INFO - Running setup.py install for blobuploader 09:14:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:14:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:14:17 INFO - Running setup.py install for requests 09:14:18 INFO - Running setup.py install for docopt 09:14:18 INFO - Successfully installed blobuploader requests docopt 09:14:18 INFO - Cleaning up... 09:14:18 INFO - Return code: 0 09:14:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:14: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')]} 09:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:18 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:18 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 09:14:18 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 09:14:18 INFO - Using env: {'DISPLAY': ':0', 09:14:18 INFO - 'HOME': '/home/cltbld', 09:14:18 INFO - 'LANG': 'en_US.UTF-8', 09:14:18 INFO - 'LANGUAGE': 'en_US:en', 09:14:18 INFO - 'LOGNAME': 'cltbld', 09:14:18 INFO - 'MAIL': '/var/mail/cltbld', 09:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:18 INFO - 'MOZ_NO_REMOTE': '1', 09:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:18 INFO - 'NO_EM_RESTART': '1', 09:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:18 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:18 INFO - 'SHELL': '/bin/bash', 09:14:18 INFO - 'SHLVL': '1', 09:14:18 INFO - 'TERM': 'linux', 09:14:18 INFO - 'TMOUT': '86400', 09:14:18 INFO - 'USER': 'cltbld', 09:14:18 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:18 INFO - '_': '/tools/buildbot/bin/python'} 09:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:14:18 INFO - Running setup.py (path:/tmp/pip-yv5ZRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:14:18 INFO - Running setup.py (path:/tmp/pip-67IxJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:14:18 INFO - Running setup.py (path:/tmp/pip-tJxzE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:14:18 INFO - Running setup.py (path:/tmp/pip-4Lf_qS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:14:18 INFO - Running setup.py (path:/tmp/pip-1O4m6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:14:18 INFO - Running setup.py (path:/tmp/pip-6BU4Mb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:14:18 INFO - Running setup.py (path:/tmp/pip-62srJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:14:18 INFO - Running setup.py (path:/tmp/pip-LBMinL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:14:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:14:18 INFO - Running setup.py (path:/tmp/pip-Mv0egb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:14:19 INFO - Running setup.py (path:/tmp/pip-KJIHbl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:14:19 INFO - Running setup.py (path:/tmp/pip-Tm_0fH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:14:19 INFO - Running setup.py (path:/tmp/pip-0jBwFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:14:19 INFO - Running setup.py (path:/tmp/pip-0E8Mo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:14:19 INFO - Running setup.py (path:/tmp/pip-nVee7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:14:19 INFO - Running setup.py (path:/tmp/pip-JF_DiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:14:19 INFO - Running setup.py (path:/tmp/pip-YF7kAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:14:19 INFO - Running setup.py (path:/tmp/pip-GB9w33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:14:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:19 INFO - Running setup.py install for manifestparser 09:14:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:14:19 INFO - Running setup.py install for mozcrash 09:14:19 INFO - Running setup.py install for mozdebug 09:14:19 INFO - Running setup.py install for mozdevice 09:14:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozfile 09:14:20 INFO - Running setup.py install for mozhttpd 09:14:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozinfo 09:14:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozInstall 09:14:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozleak 09:14:20 INFO - Running setup.py install for mozlog 09:14:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for moznetwork 09:14:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozprocess 09:14:20 INFO - Running setup.py install for mozprofile 09:14:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:14:20 INFO - Running setup.py install for mozrunner 09:14:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:14:21 INFO - Running setup.py install for mozscreenshot 09:14:21 INFO - Running setup.py install for moztest 09:14:21 INFO - Running setup.py install for mozversion 09:14:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:14:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:21 INFO - Cleaning up... 09:14:21 INFO - Return code: 0 09:14:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:14:21 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')]} 09:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:21 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')]} 09:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:21 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:21 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 09:14:21 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 09:14:21 INFO - Using env: {'DISPLAY': ':0', 09:14:21 INFO - 'HOME': '/home/cltbld', 09:14:21 INFO - 'LANG': 'en_US.UTF-8', 09:14:21 INFO - 'LANGUAGE': 'en_US:en', 09:14:21 INFO - 'LOGNAME': 'cltbld', 09:14:21 INFO - 'MAIL': '/var/mail/cltbld', 09:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:21 INFO - 'MOZ_NO_REMOTE': '1', 09:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:21 INFO - 'NO_EM_RESTART': '1', 09:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:21 INFO - 'SHELL': '/bin/bash', 09:14:21 INFO - 'SHLVL': '1', 09:14:21 INFO - 'TERM': 'linux', 09:14:21 INFO - 'TMOUT': '86400', 09:14:21 INFO - 'USER': 'cltbld', 09:14:21 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:21 INFO - '_': '/tools/buildbot/bin/python'} 09:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:14:21 INFO - Running setup.py (path:/tmp/pip-k7d4D0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:14:21 INFO - Running setup.py (path:/tmp/pip-vYPtks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:14:21 INFO - Running setup.py (path:/tmp/pip-hKU3_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:14:21 INFO - Running setup.py (path:/tmp/pip-94On6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:14:21 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)) 09:14:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:14:21 INFO - Running setup.py (path:/tmp/pip-fufkJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:14:22 INFO - Running setup.py (path:/tmp/pip-pU1tdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:14:22 INFO - Running setup.py (path:/tmp/pip-qZ5ZkW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:14:22 INFO - Running setup.py (path:/tmp/pip-0w6YnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:14:22 INFO - Running setup.py (path:/tmp/pip-89gBcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:14:22 INFO - Running setup.py (path:/tmp/pip-Zu8vfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:14:22 INFO - Running setup.py (path:/tmp/pip-9fcZds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:14:22 INFO - Running setup.py (path:/tmp/pip-5FjIKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:14:22 INFO - Running setup.py (path:/tmp/pip-BqtCoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:14:22 INFO - Running setup.py (path:/tmp/pip-kRCNgG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:14:22 INFO - Running setup.py (path:/tmp/pip-MrctvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:14:22 INFO - Running setup.py (path:/tmp/pip-7ran6J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:14:22 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)) 09:14:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:14:22 INFO - Running setup.py (path:/tmp/pip-cyFqWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 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)) 09:14:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:24 INFO - Downloading blessings-1.6.tar.gz 09:14:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:24 INFO - Installing collected packages: blessings 09:14:24 INFO - Running setup.py install for blessings 09:14:24 INFO - Successfully installed blessings 09:14:24 INFO - Cleaning up... 09:14:24 INFO - Return code: 0 09:14:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:14:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:14:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:14:25 INFO - Reading from file tmpfile_stdout 09:14:25 INFO - Current package versions: 09:14:25 INFO - argparse == 1.2.1 09:14:25 INFO - blessings == 1.6 09:14:25 INFO - blobuploader == 1.2.4 09:14:25 INFO - docopt == 0.6.1 09:14:25 INFO - manifestparser == 1.1 09:14:25 INFO - mozInstall == 1.12 09:14:25 INFO - mozcrash == 0.16 09:14:25 INFO - mozdebug == 0.1 09:14:25 INFO - mozdevice == 0.48 09:14:25 INFO - mozfile == 1.2 09:14:25 INFO - mozhttpd == 0.7 09:14:25 INFO - mozinfo == 0.9 09:14:25 INFO - mozleak == 0.1 09:14:25 INFO - mozlog == 3.1 09:14:25 INFO - moznetwork == 0.27 09:14:25 INFO - mozprocess == 0.22 09:14:25 INFO - mozprofile == 0.28 09:14:25 INFO - mozrunner == 6.11 09:14:25 INFO - mozscreenshot == 0.1 09:14:25 INFO - mozsystemmonitor == 0.0 09:14:25 INFO - moztest == 0.7 09:14:25 INFO - mozversion == 1.4 09:14:25 INFO - psutil == 3.1.1 09:14:25 INFO - requests == 1.2.3 09:14:25 INFO - wsgiref == 0.1.2 09:14:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:25 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:25 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 09:14:25 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 09:14:25 INFO - Using env: {'DISPLAY': ':0', 09:14:25 INFO - 'HOME': '/home/cltbld', 09:14:25 INFO - 'LANG': 'en_US.UTF-8', 09:14:25 INFO - 'LANGUAGE': 'en_US:en', 09:14:25 INFO - 'LOGNAME': 'cltbld', 09:14:25 INFO - 'MAIL': '/var/mail/cltbld', 09:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:25 INFO - 'MOZ_NO_REMOTE': '1', 09:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:25 INFO - 'NO_EM_RESTART': '1', 09:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:25 INFO - 'SHELL': '/bin/bash', 09:14:25 INFO - 'SHLVL': '1', 09:14:25 INFO - 'TERM': 'linux', 09:14:25 INFO - 'TMOUT': '86400', 09:14:25 INFO - 'USER': 'cltbld', 09:14:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:25 INFO - '_': '/tools/buildbot/bin/python'} 09:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 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)) 09:14:25 INFO - Cleaning up... 09:14:25 INFO - Return code: 0 09:14:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:25 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:25 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 09:14:25 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 09:14:25 INFO - Using env: {'DISPLAY': ':0', 09:14:25 INFO - 'HOME': '/home/cltbld', 09:14:25 INFO - 'LANG': 'en_US.UTF-8', 09:14:25 INFO - 'LANGUAGE': 'en_US:en', 09:14:25 INFO - 'LOGNAME': 'cltbld', 09:14:25 INFO - 'MAIL': '/var/mail/cltbld', 09:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:25 INFO - 'MOZ_NO_REMOTE': '1', 09:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:25 INFO - 'NO_EM_RESTART': '1', 09:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:25 INFO - 'SHELL': '/bin/bash', 09:14:25 INFO - 'SHLVL': '1', 09:14:25 INFO - 'TERM': 'linux', 09:14:25 INFO - 'TMOUT': '86400', 09:14:25 INFO - 'USER': 'cltbld', 09:14:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:25 INFO - '_': '/tools/buildbot/bin/python'} 09:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:25 INFO - Downloading/unpacking jsonschema 09:14:25 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 09:14:25 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 09:14:25 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 09:14:25 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 09:14:25 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 09:14:25 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 09:14:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:14:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:14:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:14:27 INFO - warning: no files found matching '*.txt' 09:14:27 INFO - no previously-included directories found matching 'build' 09:14:27 INFO - no previously-included directories found matching 'dist' 09:14:27 INFO - no previously-included directories found matching '.git*' 09:14:27 INFO - Installing collected packages: jsonschema, functools32 09:14:27 INFO - Running setup.py install for functools32 09:14:27 INFO - warning: no files found matching '*.txt' 09:14:27 INFO - no previously-included directories found matching 'build' 09:14:27 INFO - no previously-included directories found matching 'dist' 09:14:27 INFO - no previously-included directories found matching '.git*' 09:14:27 INFO - Successfully installed jsonschema functools32 09:14:27 INFO - Cleaning up... 09:14:27 INFO - Return code: 0 09:14:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:14: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')]} 09:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:27 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 0x7f078124af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, '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': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', '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 09:14:27 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 09:14:27 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 09:14:27 INFO - Using env: {'DISPLAY': ':0', 09:14:27 INFO - 'HOME': '/home/cltbld', 09:14:27 INFO - 'LANG': 'en_US.UTF-8', 09:14:27 INFO - 'LANGUAGE': 'en_US:en', 09:14:27 INFO - 'LOGNAME': 'cltbld', 09:14:27 INFO - 'MAIL': '/var/mail/cltbld', 09:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:27 INFO - 'MOZ_NO_REMOTE': '1', 09:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:27 INFO - 'NO_EM_RESTART': '1', 09:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:27 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:27 INFO - 'SHELL': '/bin/bash', 09:14:27 INFO - 'SHLVL': '1', 09:14:27 INFO - 'TERM': 'linux', 09:14:27 INFO - 'TMOUT': '86400', 09:14:27 INFO - 'USER': 'cltbld', 09:14:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:27 INFO - '_': '/tools/buildbot/bin/python'} 09:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:27 INFO - Downloading/unpacking flake8 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:27 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 09:14:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:14:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:14:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:29 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 09:14:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:14:30 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 09:14:30 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 09:14:30 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 09:14:30 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 09:14:30 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 09:14:30 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 09:14:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:14:30 INFO - no previously-included directories found matching 'docs/_build' 09:14:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:14:30 INFO - Running setup.py install for pep8 09:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:14:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:14:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:14:30 INFO - no previously-included directories found matching 'docs/_build' 09:14:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:14:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:14:30 INFO - Cleaning up... 09:14:30 INFO - Return code: 0 09:14:30 INFO - Running post-action listener: _resource_record_post_action 09:14:30 INFO - Running post-action listener: _start_resource_monitoring 09:14:30 INFO - Starting resource monitoring. 09:14:30 INFO - ##### 09:14:30 INFO - ##### Running install step. 09:14:30 INFO - ##### 09:14:30 INFO - Running pre-action listener: _resource_record_pre_action 09:14:30 INFO - Running main action method: install 09:14:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:14:30 INFO - Reading from file tmpfile_stdout 09:14:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:14:30 INFO - Reading from file tmpfile_stdout 09:14:30 INFO - Output received: 09:14:30 INFO - Usage: mozinstall [options] installer 09:14:30 INFO - Options: 09:14:30 INFO - -h, --help show this help message and exit 09:14:30 INFO - -d DEST, --destination=DEST 09:14:30 INFO - Directory to install application into. [default: 09:14:30 INFO - "/builds/slave/test-pgo"] 09:14:30 INFO - --app=APP Application being installed. [default: firefox] 09:14:30 INFO - mkdir: /builds/slave/test-pgo/build/application 09:14:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:14:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:14:45 INFO - Reading from file tmpfile_stdout 09:14:45 INFO - Output received: 09:14:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:14:45 INFO - Running post-action listener: _resource_record_post_action 09:14:45 INFO - ##### 09:14:45 INFO - ##### Running run-tests step. 09:14:45 INFO - ##### 09:14:45 INFO - Running pre-action listener: _resource_record_pre_action 09:14:45 INFO - Running main action method: run_tests 09:14:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:14:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:14:45 INFO - Python 2.7.3 09:14:45 INFO - Return code: 0 09:14:45 INFO - grabbing minidump binary from tooltool 09:14: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')]} 09:14:45 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 0x29207f0>, '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 0x288c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:14:45 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 09:14:45 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 09:14:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:45 INFO - Return code: 0 09:14:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:14:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:14:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:14:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:14:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:14:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:14:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:14:47 INFO - Return code: 0 09:14:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 09:14:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 09:14:47 INFO - Using env: {'DISPLAY': ':0', 09:14:47 INFO - 'HOME': '/home/cltbld', 09:14:47 INFO - 'LANG': 'en_US.UTF-8', 09:14:47 INFO - 'LANGUAGE': 'en_US:en', 09:14:47 INFO - 'LOGNAME': 'cltbld', 09:14:47 INFO - 'MAIL': '/var/mail/cltbld', 09:14:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:14:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:47 INFO - 'MOZ_NO_REMOTE': '1', 09:14:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:47 INFO - 'NO_EM_RESTART': '1', 09:14:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:14:47 INFO - 'SHELL': '/bin/bash', 09:14:47 INFO - 'SHLVL': '1', 09:14:47 INFO - 'TERM': 'linux', 09:14:47 INFO - 'TMOUT': '86400', 09:14:47 INFO - 'USER': 'cltbld', 09:14:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841', 09:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:47 INFO - '_': '/tools/buildbot/bin/python'} 09:14:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:14:47 INFO - mozversion application_buildid: 20160125061638 09:14:47 INFO - mozversion application_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:14:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:14:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:47 INFO - mozversion application_name: Firefox 09:14:47 INFO - mozversion application_remotingname: firefox-dev 09:14:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:47 INFO - mozversion application_vendor: Mozilla 09:14:47 INFO - mozversion application_version: 46.0a2 09:14:47 INFO - mozversion platform_buildid: 20160125061638 09:14:47 INFO - mozversion platform_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:14:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:14:47 INFO - mozversion platform_version: 46.0a2 09:14:47 INFO - using testdate: 1453828487 09:14:47 INFO - actual date: 1453828487 09:14:47 INFO - starting webserver on 'localhost:48226' 09:14:47 INFO - SUITE-START | Running 3 tests 09:14:47 INFO - TEST-START | dromaeo_css 09:14:47 INFO - operating with platform_type : linux_ 09:14:47 INFO - Initialising browser for dromaeo_css test... 09:14:47 INFO - TEST-INFO | started process 11965 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKcUbzV/profile http://localhost:48226/getInfo.html) 09:14:51 INFO - PROCESS | 11965 | __metrics Screen width/height:1600/1200 09:14:51 INFO - PROCESS | 11965 | colorDepth:24 09:14:51 INFO - PROCESS | 11965 | Browser inner width/height: 1024/697 09:14:51 INFO - PROCESS | 11965 | __metrics 09:14:51 INFO - PROCESS | 11965 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:52 INFO - TEST-INFO | 11965: exit 0 09:14:52 INFO - Browser initialized. 09:14:52 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:52 INFO - TEST-INFO | started process 12057 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKcUbzV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:03 INFO - PROCESS | 12057 | RSS: Main: 136712192 09:15:03 INFO - PROCESS | 12057 | 09:15:54 INFO - PROCESS | 12057 | 1453828554740 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] 09:18:02 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48226/tests/dromaeo/cssquery-ext.html) 09:18:03 INFO - PROCESS | 12057 | RSS: Main: 236982272 09:18:03 INFO - PROCESS | 12057 | 09:21:05 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-ext.html (next: http://localhost:48226/tests/dromaeo/cssquery-jquery.html) 09:21:06 INFO - PROCESS | 12057 | RSS: Main: 215670784 09:21:06 INFO - PROCESS | 12057 | 09:24:08 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48226/tests/dromaeo/cssquery-mootools.html) 09:24:09 INFO - PROCESS | 12057 | RSS: Main: 214872064 09:24:09 INFO - PROCESS | 12057 | 09:27:10 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48226/tests/dromaeo/cssquery-prototype.html) 09:27:11 INFO - PROCESS | 12057 | RSS: Main: 198598656 09:27:11 INFO - PROCESS | 12057 | 09:30:13 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48226/tests/dromaeo/cssquery-yui.html) 09:30:14 INFO - PROCESS | 12057 | RSS: Main: 203563008 09:30:14 INFO - PROCESS | 12057 | 09:33:16 INFO - PROCESS | 12057 | Cycle 1(1): loaded http://localhost:48226/tests/dromaeo/cssquery-yui.html (next: http://localhost:48226/tests/dromaeo/cssquery-dojo.html) 09:33:17 INFO - PROCESS | 12057 | RSS: Main: 247427072 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | __start_tp_report 09:33:17 INFO - PROCESS | 12057 | _x_x_mozilla_page_load 09:33:17 INFO - PROCESS | 12057 | _x_x_mozilla_page_load_details 09:33:17 INFO - PROCESS | 12057 | |i|pagename|runs| 09:33:17 INFO - PROCESS | 12057 | |0;dojo.html;3223.7904536205147;3255.0560337502125;3294.505824126381;3294.687004734549;3320.4521253993094;5208.687478751278;5208.817691380802;5219.739013049342;5221.347331583552;5267.078261304271;5215.217717342401;5234.42421333653;5240.056789777838;5240.266362709214;5282.154855223165;4718.528147185289;4800.087983283182;4841.491643377456;4864.124457597631;4900.093482705693;4825.25208592667;4856.223004319309;4859.659823812334;4869.610431165498;4898.338724272213;4873.902521949559;4902.632302577304;4906.239532872411;4907.950920490803;4933.1860243059855;4837.37114175155;4888.095702295087;4889.168841296988;4909.828156014541;4917.950820491785;4720.0559888022535;4744.881377965544;4782.880427989293;4783.617310615143;4789.616830653539;5115.335006449175;5147.150720131174;5148.536631703165;5207.140821764404;5208.687478751249;5471.042567550663;5661.5187709044785;5678.318601767773;5683.232763576905;5695.601307908448;5573.191887176377;5686.5735069869515;5712.371639119693;5712.942870571283;5768.451997060272;5388.191771234307;5394.676319420808;5400.83797486076;5402.729863506848;5405.405405405402;5512.834614961557;5650.3502097258515;5837.153612726131;5837.7664893404635;5856.707164641751;5477.7261136943;5495.395506494282;5530;5561.888762224733;5563.304586926634;5605.607607467438;5631.746571404296;5634.04221282383;5635.8591035224445;5642.097264437671;5418.4039755626845;5509.944900551023;5590.944090559043;5607.719614019365;5610.4670056344585;5497.835064948058;5619.353774315924;5619.662820230717;5626.803061892814;5651.406602306699;4314.848980285675;4322.589354011364;4350.499692535335;4356.782160891943;4380.2772542530765;3817;3891.494105766232;3911.530616326059;3960.7029472789654;3966.7619942803526;5257.2902658140665;5290.232916227125;5310.867228319323;5312.309399778004;5335.226392173113;5622.634528755618;5653.943460565341;5656.1798539212405;5663.207150998864;5663.603547751618;5179.792808287626;5247.685138891678;5306.28365170697;5308.150695888639;5339.973300133553;4906.190478571068;4941.308216849644;4947.381577302837;4949.282354058641;4962.60299176065;5780.653160810365;5834.504067154255;5862.765489380462;5870.26621672291;5872.354041055481;5515.834524964257;5578.497935185853;5606.215129881902;5640.802571909963;5700.857478563069;5688.829335119953;5688.829335119953;5716.657000579979;5725.914111288417;5729.197912292366;5539.7784088636;5544.695041772741;5550.777968881361;5551.861203469945;5557.861053473695;5537;5609.551235901036;5634.070378387684;5701.173329867229;5723.370429252862;5407.810726624549;5437.374701909331;5439.755211015435;5448.264484294569;5458.4814442627885;5458.4814442627885;5465.918011229915;5465.945340546544;5472.315960504937;5492.093804522209;5363.731813409236;5417.1874218865905;5430.321209848769;5438.320209973754;5465.480779325958;5474.397816240131;5512.91730624049;5513.035218836607;5521.254630624814;5523.088690366045;5273;5360.0887849064975;5383.434739352311;5414.7292635367285;5420.7560659769615 09:33:17 INFO - PROCESS | 12057 | |1;ext.html;537.7176982084408;552.513787866677;566.1620801214204;586.2788769813129;586.8327526654904;29818.552721709166;38328.808355958216;38588.80705596472;38617;38717.8064109679;41473.58526414735;42086.57913420865;42159.78920105403;42229.15541689164;42254.57745422545;7497.250274972514;7595.354394876442;8911.064338244489;9183.770405739842;9184.219341355993;10283.897161028368;10479.947600261989;10493.160547156209;10510.842337364946;10517.78964420711;10147.543360548792;10226.744331391737;10235.437050962195;10242.7439314017;10243.3341832781;10135.44255065971;10179.745506362326;10212.2851400402;10219.846702299472;10220.437875916821;10096.798064038752;10250.487475626189;10251.948740256252;10525.9473702631;10545.73635659107;42052.158956821;42312.788436057934;42508;42584.57415425837;42585.148297033884;3778.848846046155;3806.7525610835205;3836.462895194675;3885;4067.248367709588;32649.6735032649;33011.834940825385;33136;33240.16899577506;33402;4011.5587285398583;4050.0887300357185;4113.568075352075;4134.441850350195;4176.394422808676;288233;288248;289977;291220;292619.99999999785;58210.70894645499;59404.70297648484;66510.66744666343;67056;68268.31731682719;59670;59829.401705983255;60017.69991150016;60124.39875601188;60140.09789853156;18045.187966541536;18252.45242642723;18406.631867362845;18438.539036523925;18446.723299150523;14175.291235438186;14214.360353784105;14249.50126745559;14250.287485625677;14253.64365890861;22178.778212217672;22470.66294005591;22514.774852251594;22620;22710.772892270867;7786.26030527099;8031.8447568105485;8032.156623554442;8063.637136328879;8092.514449133071;1031.1441503552035;1125.178619607691;1169.5789515774316;1176.200183874956;1204.3015051270418;30875.228119297197;30986.845065774527;31010.45815990056;31985.360292794016;32458.188545286084;1162.7558212775411;1168.1355796710543;1171.988280117188;1197.2397527570056;1265.9240445573296;14053.367598458093;16341.91829040871;16847.57881052959;16865.747013794804;16870.409535666437;351101;354263;355667;356929;361521;58439;58763;58792.412075878696;58894.41105588975;58955.70522147362;1294.0618051912477;1329.6875234319928;1452.6876721504716;1467.2663668165703;1478.8669019788056;28093.157205283875;28209.57685634676;28391.574126388536;28871.422571548872;28967.420651587272;40543.79728101459;40613;40742;40794.79602601968;47149.528504714515;237677;466041;467949;469969;470726;32480.187995300308;33652.326953461285;33731;33774.49338259977;33830.15424614306;47579;48826.75586622044;48847.755761220964;49076;49603.25595116004;39302.23139958766;39752.60247397489;39853.60146398499;41004;41258.174836502505;37961.240775184895;38863.80568097141;39497.60502394939;39997.40003900002;40478;35359.46960795538;36376.63623363838;36386.4542031875;36390.27219455649;36404.63595364012;33695.66304337023;34704.65295347014;35220.295594088486;35305.82347088248;35502.11244718903;27202.863985679945;27344.453110937273;27372.452550949267;27568.172954811387;27761 09:33:17 INFO - PROCESS | 12057 | |2;jquery.html;381.3707382818349;381.82626904758337;387.891390410685;397.59246772058634;401.07952249587197;13780.793288100662;15120.773188402183;16561.33754649814;19168.52078698033;19194.712079318804;18102.36641717537;18348.54128646781;18520.259189632434;18644.906775466137;18757.15592798324;5927.318358388798;6093.451589356957;6104.298005729332;6124;6138.202033735608;4451.844185453509;4567.703099298552;4611.492735799059;5991.520678345743;6535.54251202416;6407.967960160193;6785.796426107225;6787.830304242409;6788.8302792430095;6788.830279243034;6535.281119076898;6747.291534388867;6756.49326300527;6771.864562708743;6805.183377994623;6443.355664433566;6456.838579035515;6458.547901646886;6466.094746735461;6467.644279564622;21610.459738506663;21831.672524912137;22299.55400891989;22477.775222247896;22600.095996160133;2561.4620929604807;2598.9220323390327;2673.064427450396;2698.662667166604;2760.3927136030043;13694.246816425093;13922;14331.42674293027;14335.924805639514;14494.202818844959;2052.2211661433134;2100.359390385947;2120.2473122041606;2128.074287684862;2182.301663467691;64408;65823.67088164577;67433.2288776071;67474.66262668655;67583.32416675819;14664.046836955564;15295.847041529441;15296;15298.923505382625;15301.770473442908;23714.525709485715;23773.881130594236;23994.88002560011;24044.278671639528;24057.639135412985;7874.330681891989;8229.382796290301;8286.502809831429;8359.707410240613;8365.58172091393;8079.555624440594;8092.71675491355;8109.107998120202;8157.061937877102;8170.591470426455;4403.757793321334;4574.565416285448;4720;4788.066327066189;4824.08342414947;1888.9149988250563;1946.6593346164364;1952;1966.301962803213;1968.3602829080319;959.4770849886828;1058.7723639417409;1065.1798115451058;1108.6507750058706;1136.2898188632105;17129.22918468672;17586.12069396525;17630.559236018944;17739.911300443415;18190.636187276446;1017.8829434614966;1076.2573824061374;1119.5350390541262;1121.5962253588702;1172.9237599556002;10101.797964040825;10227.386356818615;10509.84235236472;10597.41714205726;10670;391596;540837;560882;566591;576290;66438.66780666163;67305.32694673089;71925;74713;77674.6116269415;1171.37916904041;1202.5009621007184;1203.5847632566927;1205.1804772754435;1209.4859684633996;16124.758128627846;16147.838521614634;16221.72590049904;16516.256768445208;16720;26534.734652653227;32169.839150804095;33007;34418.48372274468;36497.90506284816;41938;42837.785811070746;43363.349549756145;44641.33038004368;47073.764631178;7317.5609463432365;7490.213527579525;7555.09338879338;7704.730334438268;7753.37972962173;4001.459802926684;6472.5145614080075;9116.498592577473;10068.986202759332;11786.941065294619;10060.84908726355;10269;10417.895821041693;10476.476176191007;10742.570297188338;9848.852267216142;10301.278910476194;10304.381737095799;10317.690469285933;10742.140628749525;9666.081722236377;9704.951475242578;10013.14888234479;10135.188866799204;10851.945740271249;7381.963090184515;7471.9626401867645;7491.73778917757;7576.924230757621;7588.8482230356185;8238.176182381714;8343.749687509384;10189.490525473548;10724.410157441416;11014.39420831862 09:33:17 INFO - PROCESS | 12057 | |3;mootools.html;1377.6073818961586;1511.4407669162408;1526.0309703338378;1728.8530474909633;1874.3814541201405;7105.715771369146;7741.380689544837;7949.602519874004;7953.960230198841;7960.681572737083;7871.960640196791;7891.408144389179;7941;7954.761357159295;7975.322097621709;2030.5938812237537;2076.6469700150933;2343.2033108743026;2362.492064206195;2365.325882123595;2354.682117914077;2414.553307638084;2416.2871952773976;2422.442838147227;2424.539337525873;2346.2609278077352;2352.952940941189;2386.809055275574;2389.808815294772;2391.234804862445;2372.8694921779297;2373.027058905849;2374.976250237493;2407.6629271901948;2413.5896897527464;2393.2939782764124;2409.554232466999;2409.771071748181;2433.8661373624445;2437.6343548467694;7817.687292508293;7825.765227043198;7831.451798374116;7843.019622547182;7854.528728276265;4747.145513807513;4846.951530484721;4866.294387313855;4893.510648935114;4894.706317620954;2958.8224706517676;3024.2439390152463;3069.9539506907413;3075.354175623122;3075.5232938894505;961.8893827209821;973.4354074636693;983.7491439682907;1014.9898501014969;1018.4958445569416;10944.069754070913;11081.168912331526;11094.55621775128;11099.83350249747;11104;4250.404943307939;4321.48142222929;4378.365137055109;4380.846670366522;4391.67062470316;9132.178103970675;9230.76923076915;9231.584578693975;9239.722808315626;9244.260459163252;4977.153883839684;4980.05378977993;5010.448850626428;5016.247562865527;5019.071471777733;4593.425821772278;4626.930596041062;4634.189016922025;4636.582707556337;4640.280756482751;3312.38720836646;3358.5633867597544;3387.5596172497912;3630.673239408466;3681.1533347330264;1078.428432930548;1079.5304042741275;1100.1034157161887;1102.1513434655271;1134.0304040045642;1399.0626280392162;1402.2848347342724;1448.2107251547932;1458.5332693538178;1458.555140682081;7497.962510187414;7578.242175782488;7580.772576822704;7722.3049925506975;7760.417968652374;1195.2051885496048;1204.0668481926577;1207.4040812253725;1208.64949164743;1209.0629761934572;6102.359252278447;6142.907856382158;6167.691615419211;6180.505559555225;6186;9138.954305228432;9165.54172291396;9273.026332235153;9314.068593140631;9411.623535058658;9374.5781439834;9460.101290377403;9470.337076404585;9471.621135154655;9473.147416732527;7441.627918604048;7742.612869356397;7758.3017528422715;7775.22247775218;7777.261160189773;7542.096292927153;7585.393168546613;7617.27635874591;7652.311291983749;7677.347425468898;8500.872486912578;8589.699360522602;8661.8700719488;8672.479651220947;9043.638254469748;8923.866142007746;8991.955040224757;9102.089791020844;9131.77170570741;9203.86194207074;7304.96347518259;7429.7399591014055;7433.10802703679;7435.591042492715;7447.106347238149;6955.756548520778;7021.859562808818;7535.434842386952;7716.421268405004;7716.961415192888;7222.621758760023;7457.552546847207;7493.250674932463;7506.3244308012545;7508.2867127622785;7375.225601311785;7404.222556631476;7404.518706284074;7472.8879066815125;7513.887291690519;7322.633868306457;7428.73999410018;7432.145303290191;7453;7459.738909138154;6697.966510167418;6728.529002969745;6731.966340168267;6735.4611631070375;6739.157605299338;6761.797146085625;6853.965730171317;6895.793126206222;6905.827354316182;6907.723691052302 09:33:17 INFO - PROCESS | 12057 | |4;prototype.html;335.9697627213551;339.2367173858818;343.3048077642773;346.5339118885099;346.674126321258;5992.520598352132;6055;6056.3338032816355;6061.9696901515545;6087.695615219238;5968.582199246054;5977.671228082454;5979.342272350038;5982.940170598293;5989.071693887455;4552.203364411214;4616.907661846761;4617.69984950978;4623.930641040387;4632.884177895546;4605.37827393301;4621.0757848430285;4623.8150473981;4625.629949604024;4640.048789998043;4555.954440455603;4583.243764778807;4589.0821835633005;4590.609798167143;4594.47163576188;4382.561743825624;4475.619572336355;4512.571305725951;4565.840195593155;4589.793459294323;3960.0891794887048;3977.0455090778296;3978.3236849735613;3989.6409323161056;3990.3216453203027;5596.972015139939;5604.579656525777;5605.7197140142825;5615.354234263071;5617.0731829248125;5053.418856831475;5130.384353877558;5209.2446595243855;5261.5264626183825;5264.92102618461;6240.656763877985;6244.375562443719;6245.406686364788;6252.437280644718;6259.843503912393;4417.51407345195;4459.777011149462;4464.062546865162;4465.888352791174;4465.910681786346;6420.325865784119;6574.9013764794045;6576.835579110512;6582.506312026617;6587.011948207759;4541.386912766734;4543.54564543543;4545.545445455494;4548.522405147478;4554.339620754972;4598.471175814757;4611.146937816515;4612.584867361954;4614.0310534787395;4622.14490319292;5284.39229488606;5292.682439053669;5298.284731561267;5303;5319.2021196820015;6218.160548325918;6346;6444.8388790280615;6445.484361251089;6456.7740129095255;1596.9041857488587;1621.1569983608458;1621.7405215165752;1621.764844097623;1623.2938671677857;1063.122923588043;1076.5586109694987;1077.0199118801852;1092.251807511857;1096.923215374932;6099;6101.481374083164;6113.694315284218;6117.602355846856;6119.173911521888;6566.0479230512265;6568.310327415553;6571.474282057424;6578.243501997332;6586.37429444202;5984.820455386258;6093.512518998469;6111.694415279308;6113.23584551931;6142.232220972379;3527.876524321636;3556.608773034964;3560.2523470071574;3560.786352818839;3561.1631266652316;6748.7300507979135;6750.763723269662;6760.0535924970545;6761.797146085625;6771.627560484122;6633.535652504278;6712.865742685119;6748.797536073926;6759.831004224835;6771.559848609824;6805.251422343538;6825.590464572141;6836;6836.418904393182;6846.931530684629;6620.172478440195;6620.702068407029;6623.768168114093;6629.502787291069;6629.701663425061;6385.106085148176;6537.738490460329;6541.574797638138;6543.116679248241;6546.083548303146;6808.931910681028;6819.727210911508;6821.045053692586;6824.556403833735;6827.419669328163;4503.684742068024;4509.639228861749;4512.751798651106;4514.525974772601;4515.051839113823;6473.935260647333;6628.602283862983;6638.50211234169;6638.668066596748;6679.8664026718225;6389.201349831271;6403.615783053032;6406.615603063831;6408.1349017881985;6425.58233714807;6439;6444.8388790280615;6448.290688024407;6454.903176452451;6463.289038205699;6258.179773379939;6338.968305158444;6340.175777149126;6351.2696039956;6363.077353783583;6469.7412103515335;6477.838054048498;6479.643619600967;6480.25477070143;6488.480921526361;6291.402316779899;6315.147455093687;6315.3053164152825;6318.178636777189;6324.367563243639 09:33:17 INFO - PROCESS | 12057 | |5;yui.html;862.9913700862992;952.957116929738;953.2183609440261;954.4607296877264;974.0892265731537;14520.41918323267;14613.853861461408;14640.121592704445;14662;14767.187804670752;14149.151050936925;14208;14234.074785138959;14238.359273832677;14240.928795356034;729.2598013016792;847.0343808058818;885.7209978856639;889.7864512516982;891.2602539891874;743.5501521579448;902.7066203483894;922.0088404964656;924.6024209589874;925.2413021322518;935.0415823780645;946.9725347997431;947.3510645208055;948.6205517792904;948.8197242523898;753.9886901696451;767.5049593012476;936.2182577547755;944.1832814615343;945.0643862576035;695.5791745993652;699.2378307644641;699.9930000699978;700.2192555300854;700.4851434195862;14662.853371466363;14665.780013299809;14691.338889749986;14724;14759.409623615149;14040.71918561623;14165.575032749033;14201.289935503184;14362.497312594009;14406.639834004129;11634.418279086096;11759.235649682743;11848.34834084125;11973.640790776291;12227.266364018098;3939.72421930465;3942.664873485757;3967.02807812085;3980.5223373195113;4097.467329247209;51462.22806657903;51599.226011609484;52010;52412.21381679278;53745.731271343786;10683.14534837211;10688.893111068945;10751.569937202425;10820.188485863591;10889.673309800719;19076.523086922938;19260.711089333672;19307.80692193088;19335;19341.4197574073;8102.884329467784;8249.958750206211;8287.088420273765;8376.790580235544;8407.495550267004;4714.316424118552;4715.528447155257;4716.834910778106;4742;4787.048567870485;3346.9497957530657;3383.1034775784437;3387.187075101958;3387.508811222359;3389.881354152642;622.0824284180798;626.0452809465602;632.7405763636979;634.058423241486;636.0713358496554;644.5778015399827;705.7670968580356;706.6961206681176;716.7204790131852;769.8806684963839;8459.238668519863;8799.868001979976;9178.954105229432;9283.76790580241;9907.950460247797;527.4804317747016;738.0700317599756;750.512167091395;753.3746989998289;761.950473219239;4213.53651098385;4348.173846969065;4409.228385032607;4470.284754439274;4625.560571745679;55477;59783.70108149431;60060.39939600635;60476;60563;52627.73686131545;53109.46890531122;53185.73407133017;53189.468105318454;53278.46721532813;48445.27332090022;48679.756601216766;48766.75616621894;49345.753271233414;49402.258966114816;9171.770705732144;9229.49237791928;9554.952225238829;9800.159077351193;9934.155596774355;33939.49090763591;34197.65802341945;35137.8243108793;35269.647303527665;35676;47495.28757068716;47561.286580702006;47940.520594793605;48908.75545622249;49420.258696118864;12564.560240391542;12619;12700.491980320683;12783.61649150527;12813.93593032029;12766.553170639354;12795.168314059556;12822.679433013876;12851.678708032374;13505.459781609019;12124.93937530342;12343.506259749509;12918.806217906551;12979.870201297867;13160.210387376788;12204.572839950559;12606.873931260938;12650.557230496888;12683.175593586388;12713.36433178356;12255.142140050111;12270.386480675752;12302;12312.876871231172;12314.753704925672;10290.691279261635;10481.161507079263;10485.423301718478;10528.526216320437;10530.947345263225;10460.110890574386;10575.576976920836;10621.203409744145;10665;10693.518791654238 09:33:17 INFO - PROCESS | 12057 | __end_tp_report 09:33:17 INFO - PROCESS | 12057 | __start_cc_report 09:33:17 INFO - PROCESS | 12057 | _x_x_mozilla_cycle_collect,755 09:33:17 INFO - PROCESS | 12057 | __end_cc_report 09:33:17 INFO - PROCESS | 12057 | __startTimestamp1453829597083__endTimestamp 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | ------- Summary: start ------- 09:33:17 INFO - PROCESS | 12057 | Number of tests: 6 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#0] dojo.html Cycles:165 Average:5239.89 Median:5418.40 stddev:547.44 (10.1%) stddev-sans-first:525.78 09:33:17 INFO - PROCESS | 12057 | Values: 3223.8 3255.1 3294.5 3294.7 3320.5 5208.7 5208.8 5219.7 5221.3 5267.1 5215.2 5234.4 5240.1 5240.3 5282.2 4718.5 4800.1 4841.5 4864.1 4900.1 4825.3 4856.2 4859.7 4869.6 4898.3 4873.9 4902.6 4906.2 4908.0 4933.2 4837.4 4888.1 4889.2 4909.8 4918.0 4720.1 4744.9 4782.9 4783.6 4789.6 5115.3 5147.2 5148.5 5207.1 5208.7 5471.0 5661.5 5678.3 5683.2 5695.6 5573.2 5686.6 5712.4 5712.9 5768.5 5388.2 5394.7 5400.8 5402.7 5405.4 5512.8 5650.4 5837.2 5837.8 5856.7 5477.7 5495.4 5530.0 5561.9 5563.3 5605.6 5631.7 5634.0 5635.9 5642.1 5418.4 5509.9 5590.9 5607.7 5610.5 5497.8 5619.4 5619.7 5626.8 5651.4 4314.8 4322.6 4350.5 4356.8 4380.3 3817.0 3891.5 3911.5 3960.7 3966.8 5257.3 5290.2 5310.9 5312.3 5335.2 5622.6 5653.9 5656.2 5663.2 5663.6 5179.8 5247.7 5306.3 5308.2 5340.0 4906.2 4941.3 4947.4 4949.3 4962.6 5780.7 5834.5 5862.8 5870.3 5872.4 5515.8 5578.5 5606.2 5640.8 5700.9 5688.8 5688.8 5716.7 5725.9 5729.2 5539.8 5544.7 5550.8 5551.9 5557.9 5537.0 5609.6 5634.1 5701.2 5723.4 5407.8 5437.4 5439.8 5448.3 5458.5 5458.5 5465.9 5465.9 5472.3 5492.1 5363.7 5417.2 5430.3 5438.3 5465.5 5474.4 5512.9 5513.0 5521.3 5523.1 5273.0 5360.1 5383.4 5414.7 5420.8 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#1] ext.html Cycles:180 Average:53025.67 Median:35263.06 stddev:95895.95 (271.9%) stddev-sans-first:96083.98 09:33:17 INFO - PROCESS | 12057 | Values: 537.7 552.5 566.2 586.3 586.8 29818.6 38328.8 38588.8 38617.0 38717.8 41473.6 42086.6 42159.8 42229.2 42254.6 7497.3 7595.4 8911.1 9183.8 9184.2 10283.9 10479.9 10493.2 10510.8 10517.8 10147.5 10226.7 10235.4 10242.7 10243.3 10135.4 10179.7 10212.3 10219.8 10220.4 10096.8 10250.5 10251.9 10525.9 10545.7 42052.2 42312.8 42508.0 42584.6 42585.1 3778.8 3806.8 3836.5 3885.0 4067.2 32649.7 33011.8 33136.0 33240.2 33402.0 4011.6 4050.1 4113.6 4134.4 4176.4 288233.0 288248.0 289977.0 291220.0 292620.0 58210.7 59404.7 66510.7 67056.0 68268.3 59670.0 59829.4 60017.7 60124.4 60140.1 18045.2 18252.5 18406.6 18438.5 18446.7 14175.3 14214.4 14249.5 14250.3 14253.6 22178.8 22470.7 22514.8 22620.0 22710.8 7786.3 8031.8 8032.2 8063.6 8092.5 1031.1 1125.2 1169.6 1176.2 1204.3 30875.2 30986.8 31010.5 31985.4 32458.2 1162.8 1168.1 1172.0 1197.2 1265.9 14053.4 16341.9 16847.6 16865.7 16870.4 351101.0 354263.0 355667.0 356929.0 361521.0 58439.0 58763.0 58792.4 58894.4 58955.7 1294.1 1329.7 1452.7 1467.3 1478.9 28093.2 28209.6 28391.6 28871.4 28967.4 40543.8 40613.0 40742.0 40794.8 47149.5 237677.0 466041.0 467949.0 469969.0 470726.0 32480.2 33652.3 33731.0 33774.5 33830.2 47579.0 48826.8 48847.8 49076.0 49603.3 39302.2 39752.6 39853.6 41004.0 41258.2 37961.2 38863.8 39497.6 39997.4 40478.0 35359.5 36376.6 36386.5 36390.3 36404.6 33695.7 34704.7 35220.3 35305.8 35502.1 27202.9 27344.5 27372.5 27568.2 27761.0 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#2] jquery.html Cycles:180 Average:28429.87 Median:2729.53 stddev:86841.20 (3181.5%) stddev-sans-first:87059.27 09:33:17 INFO - PROCESS | 12057 | Values: 381.4 381.8 387.9 397.6 401.1 13780.8 15120.8 16561.3 19168.5 19194.7 18102.4 18348.5 18520.3 18644.9 18757.2 5927.3 6093.5 6104.3 6124.0 6138.2 4451.8 4567.7 4611.5 5991.5 6535.5 6408.0 6785.8 6787.8 6788.8 6788.8 6535.3 6747.3 6756.5 6771.9 6805.2 6443.4 6456.8 6458.5 6466.1 6467.6 21610.5 21831.7 22299.6 22477.8 22600.1 2561.5 2598.9 2673.1 2698.7 2760.4 13694.2 13922.0 14331.4 14335.9 14494.2 2052.2 2100.4 2120.2 2128.1 2182.3 64408.0 65823.7 67433.2 67474.7 67583.3 14664.0 15295.8 15296.0 15298.9 15301.8 23714.5 23773.9 23994.9 24044.3 24057.6 7874.3 8229.4 8286.5 8359.7 8365.6 8079.6 8092.7 8109.1 8157.1 8170.6 4403.8 4574.6 4720.0 4788.1 4824.1 1888.9 1946.7 1952.0 1966.3 1968.4 959.5 1058.8 1065.2 1108.7 1136.3 17129.2 17586.1 17630.6 17739.9 18190.6 1017.9 1076.3 1119.5 1121.6 1172.9 10101.8 10227.4 10509.8 10597.4 10670.0 391596.0 540837.0 560882.0 566591.0 576290.0 66438.7 67305.3 71925.0 74713.0 77674.6 1171.4 1202.5 1203.6 1205.2 1209.5 16124.8 16147.8 16221.7 16516.3 16720.0 26534.7 32169.8 33007.0 34418.5 36497.9 41938.0 42837.8 43363.3 44641.3 47073.8 7317.6 7490.2 7555.1 7704.7 7753.4 4001.5 6472.5 9116.5 10069.0 11786.9 10060.8 10269.0 10417.9 10476.5 10742.6 9848.9 10301.3 10304.4 10317.7 10742.1 9666.1 9705.0 10013.1 10135.2 10851.9 7382.0 7472.0 7491.7 7576.9 7588.8 8238.2 8343.7 10189.5 10724.4 11014.4 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#3] mootools.html Cycles:180 Average:5653.53 Median:6737.31 stddev:2901.67 (43.1%) stddev-sans-first:2892.01 09:33:17 INFO - PROCESS | 12057 | Values: 1377.6 1511.4 1526.0 1728.9 1874.4 7105.7 7741.4 7949.6 7954.0 7960.7 7872.0 7891.4 7941.0 7954.8 7975.3 2030.6 2076.6 2343.2 2362.5 2365.3 2354.7 2414.6 2416.3 2422.4 2424.5 2346.3 2353.0 2386.8 2389.8 2391.2 2372.9 2373.0 2375.0 2407.7 2413.6 2393.3 2409.6 2409.8 2433.9 2437.6 7817.7 7825.8 7831.5 7843.0 7854.5 4747.1 4847.0 4866.3 4893.5 4894.7 2958.8 3024.2 3070.0 3075.4 3075.5 961.9 973.4 983.7 1015.0 1018.5 10944.1 11081.2 11094.6 11099.8 11104.0 4250.4 4321.5 4378.4 4380.8 4391.7 9132.2 9230.8 9231.6 9239.7 9244.3 4977.2 4980.1 5010.4 5016.2 5019.1 4593.4 4626.9 4634.2 4636.6 4640.3 3312.4 3358.6 3387.6 3630.7 3681.2 1078.4 1079.5 1100.1 1102.2 1134.0 1399.1 1402.3 1448.2 1458.5 1458.6 7498.0 7578.2 7580.8 7722.3 7760.4 1195.2 1204.1 1207.4 1208.6 1209.1 6102.4 6142.9 6167.7 6180.5 6186.0 9139.0 9165.5 9273.0 9314.1 9411.6 9374.6 9460.1 9470.3 9471.6 9473.1 7441.6 7742.6 7758.3 7775.2 7777.3 7542.1 7585.4 7617.3 7652.3 7677.3 8500.9 8589.7 8661.9 8672.5 9043.6 8923.9 8992.0 9102.1 9131.8 9203.9 7305.0 7429.7 7433.1 7435.6 7447.1 6955.8 7021.9 7535.4 7716.4 7717.0 7222.6 7457.6 7493.3 7506.3 7508.3 7375.2 7404.2 7404.5 7472.9 7513.9 7322.6 7428.7 7432.1 7453.0 7459.7 6698.0 6728.5 6732.0 6735.5 6739.2 6761.8 6854.0 6895.8 6905.8 6907.7 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#4] prototype.html Cycles:180 Average:5331.99 Median:6090.60 stddev:1608.72 (26.4%) stddev-sans-first:1568.92 09:33:17 INFO - PROCESS | 12057 | Values: 336.0 339.2 343.3 346.5 346.7 5992.5 6055.0 6056.3 6062.0 6087.7 5968.6 5977.7 5979.3 5982.9 5989.1 4552.2 4616.9 4617.7 4623.9 4632.9 4605.4 4621.1 4623.8 4625.6 4640.0 4556.0 4583.2 4589.1 4590.6 4594.5 4382.6 4475.6 4512.6 4565.8 4589.8 3960.1 3977.0 3978.3 3989.6 3990.3 5597.0 5604.6 5605.7 5615.4 5617.1 5053.4 5130.4 5209.2 5261.5 5264.9 6240.7 6244.4 6245.4 6252.4 6259.8 4417.5 4459.8 4464.1 4465.9 4465.9 6420.3 6574.9 6576.8 6582.5 6587.0 4541.4 4543.5 4545.5 4548.5 4554.3 4598.5 4611.1 4612.6 4614.0 4622.1 5284.4 5292.7 5298.3 5303.0 5319.2 6218.2 6346.0 6444.8 6445.5 6456.8 1596.9 1621.2 1621.7 1621.8 1623.3 1063.1 1076.6 1077.0 1092.3 1096.9 6099.0 6101.5 6113.7 6117.6 6119.2 6566.0 6568.3 6571.5 6578.2 6586.4 5984.8 6093.5 6111.7 6113.2 6142.2 3527.9 3556.6 3560.3 3560.8 3561.2 6748.7 6750.8 6760.1 6761.8 6771.6 6633.5 6712.9 6748.8 6759.8 6771.6 6805.3 6825.6 6836.0 6836.4 6846.9 6620.2 6620.7 6623.8 6629.5 6629.7 6385.1 6537.7 6541.6 6543.1 6546.1 6808.9 6819.7 6821.0 6824.6 6827.4 4503.7 4509.6 4512.8 4514.5 4515.1 6473.9 6628.6 6638.5 6638.7 6679.9 6389.2 6403.6 6406.6 6408.1 6425.6 6439.0 6444.8 6448.3 6454.9 6463.3 6258.2 6339.0 6340.2 6351.3 6363.1 6469.7 6477.8 6479.6 6480.3 6488.5 6291.4 6315.1 6315.3 6318.2 6324.4 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - PROCESS | 12057 | [#5] yui.html Cycles:180 Average:14758.77 Median:4714.92 stddev:16684.15 (353.9%) stddev-sans-first:16698.32 09:33:17 INFO - PROCESS | 12057 | Values: 863.0 953.0 953.2 954.5 974.1 14520.4 14613.9 14640.1 14662.0 14767.2 14149.2 14208.0 14234.1 14238.4 14240.9 729.3 847.0 885.7 889.8 891.3 743.6 902.7 922.0 924.6 925.2 935.0 947.0 947.4 948.6 948.8 754.0 767.5 936.2 944.2 945.1 695.6 699.2 700.0 700.2 700.5 14662.9 14665.8 14691.3 14724.0 14759.4 14040.7 14165.6 14201.3 14362.5 14406.6 11634.4 11759.2 11848.3 11973.6 12227.3 3939.7 3942.7 3967.0 3980.5 4097.5 51462.2 51599.2 52010.0 52412.2 53745.7 10683.1 10688.9 10751.6 10820.2 10889.7 19076.5 19260.7 19307.8 19335.0 19341.4 8102.9 8250.0 8287.1 8376.8 8407.5 4714.3 4715.5 4716.8 4742.0 4787.0 3346.9 3383.1 3387.2 3387.5 3389.9 622.1 626.0 632.7 634.1 636.1 644.6 705.8 706.7 716.7 769.9 8459.2 8799.9 9179.0 9283.8 9908.0 527.5 738.1 750.5 753.4 762.0 4213.5 4348.2 4409.2 4470.3 4625.6 55477.0 59783.7 60060.4 60476.0 60563.0 52627.7 53109.5 53185.7 53189.5 53278.5 48445.3 48679.8 48766.8 49345.8 49402.3 9171.8 9229.5 9555.0 9800.2 9934.2 33939.5 34197.7 35137.8 35269.6 35676.0 47495.3 47561.3 47940.5 48908.8 49420.3 12564.6 12619.0 12700.5 12783.6 12813.9 12766.6 12795.2 12822.7 12851.7 13505.5 12124.9 12343.5 12918.8 12979.9 13160.2 12204.6 12606.9 12650.6 12683.2 12713.4 12255.1 12270.4 12302.0 12312.9 12314.8 10290.7 10481.2 10485.4 10528.5 10530.9 10460.1 10575.6 10621.2 10665.0 10693.5 09:33:17 INFO - PROCESS | 12057 | -------- Summary: end -------- 09:33:17 INFO - PROCESS | 12057 | 09:33:17 INFO - TEST-INFO | 12057: exit 0 09:33:17 INFO - TEST-OK | dromaeo_css | took 1110426ms 09:33:17 INFO - TEST-START | kraken 09:33:17 INFO - operating with platform_type : linux_ 09:33:17 INFO - Initialising browser for kraken test... 09:33:17 INFO - TEST-INFO | started process 12266 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5egRak/profile http://localhost:48226/getInfo.html) 09:33:21 INFO - PROCESS | 12266 | __metrics Screen width/height:1600/1200 09:33:21 INFO - PROCESS | 12266 | colorDepth:24 09:33:21 INFO - PROCESS | 12266 | Browser inner width/height: 1024/697 09:33:21 INFO - PROCESS | 12266 | __metrics 09:33:21 INFO - PROCESS | 12266 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:22 INFO - TEST-INFO | 12266: exit 0 09:33:22 INFO - Browser initialized. 09:33:22 INFO - Running cycle 1/1 for kraken test... 09:33:22 INFO - TEST-INFO | started process 12352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5egRak/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:34 INFO - PROCESS | 12352 | RSS: Main: 136675328 09:33:34 INFO - PROCESS | 12352 | 09:33:36 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48226/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:37 INFO - PROCESS | 12352 | RSS: Main: 174460928 09:33:37 INFO - PROCESS | 12352 | 09:33:39 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48226/tests/kraken/driver.html?testName=audio-dft) 09:33:40 INFO - PROCESS | 12352 | RSS: Main: 168648704 09:33:40 INFO - PROCESS | 12352 | 09:33:43 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48226/tests/kraken/driver.html?testName=audio-fft) 09:33:43 INFO - PROCESS | 12352 | RSS: Main: 168464384 09:33:43 INFO - PROCESS | 12352 | 09:33:45 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48226/tests/kraken/driver.html?testName=audio-oscillator) 09:33:46 INFO - PROCESS | 12352 | RSS: Main: 168136704 09:33:46 INFO - PROCESS | 12352 | 09:33:48 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:49 INFO - PROCESS | 12352 | RSS: Main: 164851712 09:33:49 INFO - PROCESS | 12352 | 09:33:52 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48226/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:52 INFO - PROCESS | 12352 | RSS: Main: 164323328 09:33:52 INFO - PROCESS | 12352 | 09:33:56 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48226/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:56 INFO - PROCESS | 12352 | RSS: Main: 164208640 09:33:56 INFO - PROCESS | 12352 | 09:33:59 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48226/tests/kraken/driver.html?testName=json-parse-financial) 09:34:00 INFO - PROCESS | 12352 | RSS: Main: 165822464 09:34:00 INFO - PROCESS | 12352 | 09:34:01 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:02 INFO - PROCESS | 12352 | RSS: Main: 170123264 09:34:02 INFO - PROCESS | 12352 | 09:34:03 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:04 INFO - PROCESS | 12352 | RSS: Main: 171368448 09:34:04 INFO - PROCESS | 12352 | 09:34:06 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:07 INFO - PROCESS | 12352 | RSS: Main: 180101120 09:34:07 INFO - PROCESS | 12352 | 09:34:09 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:10 INFO - PROCESS | 12352 | RSS: Main: 184610816 09:34:10 INFO - PROCESS | 12352 | 09:34:12 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:13 INFO - PROCESS | 12352 | RSS: Main: 182657024 09:34:13 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | Cycle 1(1): loaded http://localhost:48226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48226/tests/kraken/driver.html?testName=ai-astar) 09:34:14 INFO - PROCESS | 12352 | RSS: Main: 243793920 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | __start_tp_report 09:34:14 INFO - PROCESS | 12352 | _x_x_mozilla_page_load 09:34:14 INFO - PROCESS | 12352 | _x_x_mozilla_page_load_details 09:34:14 INFO - PROCESS | 12352 | |i|pagename|runs| 09:34:14 INFO - PROCESS | 12352 | |0;ai-astar;110;110;106;109;109;111;110;111;100;111 09:34:14 INFO - PROCESS | 12352 | |1;audio-beat-detection;159;125;149;161;126;149;147;127;160;126 09:34:14 INFO - PROCESS | 12352 | |2;audio-dft;160;161;159;160;161;161;159;160;159;158 09:34:14 INFO - PROCESS | 12352 | |3;audio-fft;73;73;72;152;72;74;76;73;167;72 09:34:14 INFO - PROCESS | 12352 | |4;audio-oscillator;94;94;136;95;95;94;150;94;96;136 09:34:14 INFO - PROCESS | 12352 | |5;imaging-gaussian-blur;108;109;109;108;109;109;109;110;109;108 09:34:14 INFO - PROCESS | 12352 | |6;imaging-darkroom;147;148;146;146;146;147;146;146;146;145 09:34:14 INFO - PROCESS | 12352 | |7;imaging-desaturate;96;96;96;97;95;96;96;96;96;96 09:34:14 INFO - PROCESS | 12352 | |8;json-parse-financial;55;56;58;55;56;56;55;55;58;53 09:34:14 INFO - PROCESS | 12352 | |9;json-stringify-tinderbox;64;63;64;63;64;64;64;68;64;64 09:34:14 INFO - PROCESS | 12352 | |10;stanford-crypto-aes;80;81;82;88;81;83;82;81;83;82 09:34:14 INFO - PROCESS | 12352 | |11;stanford-crypto-ccm;117;117;114;111;116;118;125;110;111;119 09:34:14 INFO - PROCESS | 12352 | |12;stanford-crypto-pbkdf2;138;145;138;137;137;138;136;136;146;136 09:34:14 INFO - PROCESS | 12352 | |13;stanford-crypto-sha256-iterative;65;67;69;66;67;66;66;67;66;67 09:34:14 INFO - PROCESS | 12352 | __end_tp_report 09:34:14 INFO - PROCESS | 12352 | __start_cc_report 09:34:14 INFO - PROCESS | 12352 | _x_x_mozilla_cycle_collect,934 09:34:14 INFO - PROCESS | 12352 | __end_cc_report 09:34:14 INFO - PROCESS | 12352 | __startTimestamp1453829654978__endTimestamp 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | ------- Summary: start ------- 09:34:14 INFO - PROCESS | 12352 | Number of tests: 14 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.40 (3.1%) stddev-sans-first:3.57 09:34:14 INFO - PROCESS | 12352 | Values: 110.0 110.0 106.0 109.0 109.0 111.0 110.0 111.0 100.0 111.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.00 stddev:15.33 (10.3%) stddev-sans-first:15.11 09:34:14 INFO - PROCESS | 12352 | Values: 159.0 125.0 149.0 161.0 126.0 149.0 147.0 127.0 160.0 126.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 09:34:14 INFO - PROCESS | 12352 | Values: 160.0 161.0 159.0 160.0 161.0 161.0 159.0 160.0 159.0 158.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#3] audio-fft Cycles:10 Average:90.40 Median:73.00 stddev:36.61 (50.2%) stddev-sans-first:38.29 09:34:14 INFO - PROCESS | 12352 | Values: 73.0 73.0 72.0 152.0 72.0 74.0 76.0 73.0 167.0 72.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:22.60 (24.0%) stddev-sans-first:23.36 09:34:14 INFO - PROCESS | 12352 | Values: 94.0 94.0 136.0 95.0 95.0 94.0 150.0 94.0 96.0 136.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:34:14 INFO - PROCESS | 12352 | Values: 108.0 109.0 109.0 108.0 109.0 109.0 109.0 110.0 109.0 108.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 09:34:14 INFO - PROCESS | 12352 | Values: 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:34:14 INFO - PROCESS | 12352 | Values: 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.49 (2.7%) stddev-sans-first:1.56 09:34:14 INFO - PROCESS | 12352 | Values: 55.0 56.0 58.0 55.0 56.0 56.0 55.0 55.0 58.0 53.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.40 (2.2%) stddev-sans-first:1.48 09:34:14 INFO - PROCESS | 12352 | Values: 64.0 63.0 64.0 63.0 64.0 64.0 64.0 68.0 64.0 64.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.21 (2.7%) stddev-sans-first:2.19 09:34:14 INFO - PROCESS | 12352 | Values: 80.0 81.0 82.0 88.0 81.0 83.0 82.0 81.0 83.0 82.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:4.54 (3.9%) stddev-sans-first:4.80 09:34:14 INFO - PROCESS | 12352 | Values: 117.0 117.0 114.0 111.0 116.0 118.0 125.0 110.0 111.0 119.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:138.00 stddev:3.68 (2.7%) stddev-sans-first:3.90 09:34:14 INFO - PROCESS | 12352 | Values: 138.0 145.0 138.0 137.0 137.0 138.0 136.0 136.0 146.0 136.0 09:34:14 INFO - PROCESS | 12352 | 09:34:14 INFO - PROCESS | 12352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:0.97 09:34:14 INFO - PROCESS | 12352 | Values: 65.0 67.0 69.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 09:34:14 INFO - PROCESS | 12352 | -------- Summary: end -------- 09:34:15 INFO - PROCESS | 12352 | 09:34:15 INFO - TEST-INFO | 12352: exit 0 09:34:15 INFO - TEST-OK | kraken | took 58170ms 09:34:15 INFO - TEST-START | v8_7 09:34:15 INFO - operating with platform_type : linux_ 09:34:15 INFO - Initialising browser for v8_7 test... 09:34:15 INFO - TEST-INFO | started process 12608 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW9peYd/profile http://localhost:48226/getInfo.html) 09:34:19 INFO - PROCESS | 12608 | __metrics Screen width/height:1600/1200 09:34:19 INFO - PROCESS | 12608 | colorDepth:24 09:34:19 INFO - PROCESS | 12608 | Browser inner width/height: 1024/697 09:34:19 INFO - PROCESS | 12608 | __metrics 09:34:19 INFO - PROCESS | 12608 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:20 INFO - TEST-INFO | 12608: exit 0 09:34:20 INFO - Browser initialized. 09:34:20 INFO - Running cycle 1/1 for v8_7 test... 09:34:20 INFO - TEST-INFO | started process 12699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW9peYd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:32 INFO - PROCESS | 12699 | RSS: Main: 137031680 09:34:32 INFO - PROCESS | 12699 | 09:34:54 INFO - PROCESS | 12699 | Cycle 1(1): loaded http://localhost:48226/tests/v8_7/run.html (next: http://localhost:48226/tests/v8_7/run.html) 09:34:55 INFO - PROCESS | 12699 | RSS: Main: 412344320 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | __start_tp_report 09:34:55 INFO - PROCESS | 12699 | _x_x_mozilla_page_load 09:34:55 INFO - PROCESS | 12699 | _x_x_mozilla_page_load_details 09:34:55 INFO - PROCESS | 12699 | |i|pagename|runs| 09:34:55 INFO - PROCESS | 12699 | |0;Richards;166.41704110500916 09:34:55 INFO - PROCESS | 12699 | |1;DeltaBlue;171.76228100309172 09:34:55 INFO - PROCESS | 12699 | |2;Encrypt;279.56388034665923 09:34:55 INFO - PROCESS | 12699 | |3;Decrypt;5240.837696335078 09:34:55 INFO - PROCESS | 12699 | |4;RayTrace;1009.0817356205853 09:34:55 INFO - PROCESS | 12699 | |5;Earley;572.737686139748 09:34:55 INFO - PROCESS | 12699 | |6;Boyer;11021.978021978022 09:34:55 INFO - PROCESS | 12699 | |7;RegExp;40940 09:34:55 INFO - PROCESS | 12699 | |8;Splay;494.80455220188026 09:34:55 INFO - PROCESS | 12699 | |9;NavierStokes;4822.115384615385 09:34:55 INFO - PROCESS | 12699 | __end_tp_report 09:34:55 INFO - PROCESS | 12699 | __startTimestamp1453829695232__endTimestamp 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | ------- Summary: start ------- 09:34:55 INFO - PROCESS | 12699 | Number of tests: 10 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 166.4 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#1] DeltaBlue Cycles:1 Average:171.76 Median:171.76 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 171.8 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 279.6 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 5240.8 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#4] RayTrace Cycles:1 Average:1009.08 Median:1009.08 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 1009.1 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#5] Earley Cycles:1 Average:572.74 Median:572.74 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 572.7 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#6] Boyer Cycles:1 Average:11021.98 Median:11021.98 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 11022.0 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#7] RegExp Cycles:1 Average:40940.00 Median:40940.00 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 40940.0 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#8] Splay Cycles:1 Average:494.80 Median:494.80 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 494.8 09:34:55 INFO - PROCESS | 12699 | 09:34:55 INFO - PROCESS | 12699 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:34:55 INFO - PROCESS | 12699 | Values: 4822.1 09:34:55 INFO - PROCESS | 12699 | -------- Summary: end -------- 09:34:55 INFO - PROCESS | 12699 | 09:34:56 INFO - TEST-INFO | 12699: exit 0 09:34:56 INFO - TEST-OK | v8_7 | took 40224ms 09:34:56 INFO - SUITE-END | took 1208s 09:34:56 INFO - Completed test suite (00:20:08) 09:34:56 INFO - Working with test: dromaeo_css 09:34:56 INFO - Generating results file: dromaeo_css 09:34:56 INFO - Working with test: kraken 09:34:56 INFO - Generating results file: kraken 09:34:56 INFO - javascript benchmark 09:34:56 INFO - Working with test: v8_7 09:34:56 INFO - Generating results file: v8_7 09:34:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:34:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 09:34:56 INFO - process_Request line: dromaeo_css 7263.13 graph.html#tests=[[72,52,35]] 09:34:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:34:56 INFO - process_Request line: kraken 1484.60 graph.html#tests=[[232,52,35]] 09:34:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:34:56 INFO - process_Request line: v8_7 21801.04 graph.html#tests=[[230,52,35]] 09:34:56 INFO - RETURN: dromaeo_css: 7263.13 09:34:56 INFO - RETURN: kraken: 1484.60 09:34:56 INFO - RETURN: v8_7: 21801.04 09:34:56 INFO - javascript benchmark 09:34:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.7904536205147, 3255.0560337502125, 3294.505824126381, 3294.687004734549, 3320.4521253993094, 5208.687478751278, 5208.817691380802, 5219.739013049342, 5221.347331583552, 5267.078261304271, 5215.217717342401, 5234.42421333653, 5240.056789777838, 5240.266362709214, 5282.154855223165, 4718.528147185289, 4800.087983283182, 4841.491643377456, 4864.124457597631, 4900.093482705693, 4825.25208592667, 4856.223004319309, 4859.659823812334, 4869.610431165498, 4898.338724272213, 4873.902521949559, 4902.632302577304, 4906.239532872411, 4907.950920490803, 4933.1860243059855, 4837.37114175155, 4888.095702295087, 4889.168841296988, 4909.828156014541, 4917.950820491785, 4720.0559888022535, 4744.881377965544, 4782.880427989293, 4783.617310615143, 4789.616830653539, 5115.335006449175, 5147.150720131174, 5148.536631703165, 5207.140821764404, 5208.687478751249, 5471.042567550663, 5661.5187709044785, 5678.318601767773, 5683.232763576905, 5695.601307908448, 5573.191887176377, 5686.5735069869515, 5712.371639119693, 5712.942870571283, 5768.451997060272, 5388.191771234307, 5394.676319420808, 5400.83797486076, 5402.729863506848, 5405.405405405402, 5512.834614961557, 5650.3502097258515, 5837.153612726131, 5837.7664893404635, 5856.707164641751, 5477.7261136943, 5495.395506494282, 5530.0, 5561.888762224733, 5563.304586926634, 5605.607607467438, 5631.746571404296, 5634.04221282383, 5635.8591035224445, 5642.097264437671, 5418.4039755626845, 5509.944900551023, 5590.944090559043, 5607.719614019365, 5610.4670056344585, 5497.835064948058, 5619.353774315924, 5619.662820230717, 5626.803061892814, 5651.406602306699, 4314.848980285675, 4322.589354011364, 4350.499692535335, 4356.782160891943, 4380.2772542530765, 3817.0, 3891.494105766232, 3911.530616326059, 3960.7029472789654, 3966.7619942803526, 5257.2902658140665, 5290.232916227125, 5310.867228319323, 5312.309399778004, 5335.226392173113, 5622.634528755618, 5653.943460565341, 5656.1798539212405, 5663.207150998864, 5663.603547751618, 5179.792808287626, 5247.685138891678, 5306.28365170697, 5308.150695888639, 5339.973300133553, 4906.190478571068, 4941.308216849644, 4947.381577302837, 4949.282354058641, 4962.60299176065, 5780.653160810365, 5834.504067154255, 5862.765489380462, 5870.26621672291, 5872.354041055481, 5515.834524964257, 5578.497935185853, 5606.215129881902, 5640.802571909963, 5700.857478563069, 5688.829335119953, 5688.829335119953, 5716.657000579979, 5725.914111288417, 5729.197912292366, 5539.7784088636, 5544.695041772741, 5550.777968881361, 5551.861203469945, 5557.861053473695, 5537.0, 5609.551235901036, 5634.070378387684, 5701.173329867229, 5723.370429252862, 5407.810726624549, 5437.374701909331, 5439.755211015435, 5448.264484294569, 5458.4814442627885, 5458.4814442627885, 5465.918011229915, 5465.945340546544, 5472.315960504937, 5492.093804522209, 5363.731813409236, 5417.1874218865905, 5430.321209848769, 5438.320209973754, 5465.480779325958, 5474.397816240131, 5512.91730624049, 5513.035218836607, 5521.254630624814, 5523.088690366045, 5273.0, 5360.0887849064975, 5383.434739352311, 5414.7292635367285, 5420.7560659769615], "unit": "score", "name": "dojo.html", "value": 5206.727247529115}, {"lowerIsBetter": false, "replicates": [537.7176982084408, 552.513787866677, 566.1620801214204, 586.2788769813129, 586.8327526654904, 29818.552721709166, 38328.808355958216, 38588.80705596472, 38617.0, 38717.8064109679, 41473.58526414735, 42086.57913420865, 42159.78920105403, 42229.15541689164, 42254.57745422545, 7497.250274972514, 7595.354394876442, 8911.064338244489, 9183.770405739842, 9184.219341355993, 10283.897161028368, 10479.947600261989, 10493.160547156209, 10510.842337364946, 10517.78964420711, 10147.543360548792, 10226.744331391737, 10235.437050962195, 10242.7439314017, 10243.3341832781, 10135.44255065971, 10179.745506362326, 10212.2851400402, 10219.846702299472, 10220.437875916821, 10096.798064038752, 10250.487475626189, 10251.948740256252, 10525.9473702631, 10545.73635659107, 42052.158956821, 42312.788436057934, 42508.0, 42584.57415425837, 42585.148297033884, 3778.848846046155, 3806.7525610835205, 3836.462895194675, 3885.0, 4067.248367709588, 32649.6735032649, 33011.834940825385, 33136.0, 33240.16899577506, 33402.0, 4011.5587285398583, 4050.0887300357185, 4113.568075352075, 4134.441850350195, 4176.394422808676, 288233.0, 288248.0, 289977.0, 291220.0, 292619.99999999785, 58210.70894645499, 59404.70297648484, 66510.66744666343, 67056.0, 68268.31731682719, 59670.0, 59829.401705983255, 60017.69991150016, 60124.39875601188, 60140.09789853156, 18045.187966541536, 18252.45242642723, 18406.631867362845, 18438.539036523925, 18446.723299150523, 14175.291235438186, 14214.360353784105, 14249.50126745559, 14250.287485625677, 14253.64365890861, 22178.778212217672, 22470.66294005591, 22514.774852251594, 22620.0, 22710.772892270867, 7786.26030527099, 8031.8447568105485, 8032.156623554442, 8063.637136328879, 8092.514449133071, 1031.1441503552035, 1125.178619607691, 1169.5789515774316, 1176.200183874956, 1204.3015051270418, 30875.228119297197, 30986.845065774527, 31010.45815990056, 31985.360292794016, 32458.188545286084, 1162.7558212775411, 1168.1355796710543, 1171.988280117188, 1197.2397527570056, 1265.9240445573296, 14053.367598458093, 16341.91829040871, 16847.57881052959, 16865.747013794804, 16870.409535666437, 351101.0, 354263.0, 355667.0, 356929.0, 361521.0, 58439.0, 58763.0, 58792.412075878696, 58894.41105588975, 58955.70522147362, 1294.0618051912477, 1329.6875234319928, 1452.6876721504716, 1467.2663668165703, 1478.8669019788056, 28093.157205283875, 28209.57685634676, 28391.574126388536, 28871.422571548872, 28967.420651587272, 40543.79728101459, 40613.0, 40742.0, 40794.79602601968, 47149.528504714515, 237677.0, 466041.0, 467949.0, 469969.0, 470726.0, 32480.187995300308, 33652.326953461285, 33731.0, 33774.49338259977, 33830.15424614306, 47579.0, 48826.75586622044, 48847.755761220964, 49076.0, 49603.25595116004, 39302.23139958766, 39752.60247397489, 39853.60146398499, 41004.0, 41258.174836502505, 37961.240775184895, 38863.80568097141, 39497.60502394939, 39997.40003900002, 40478.0, 35359.46960795538, 36376.63623363838, 36386.4542031875, 36390.27219455649, 36404.63595364012, 33695.66304337023, 34704.65295347014, 35220.295594088486, 35305.82347088248, 35502.11244718903, 27202.863985679945, 27344.453110937273, 27372.452550949267, 27568.172954811387, 27761.0], "unit": "score", "name": "ext.html", "value": 20150.592327147}, {"lowerIsBetter": false, "replicates": [381.3707382818349, 381.82626904758337, 387.891390410685, 397.59246772058634, 401.07952249587197, 13780.793288100662, 15120.773188402183, 16561.33754649814, 19168.52078698033, 19194.712079318804, 18102.36641717537, 18348.54128646781, 18520.259189632434, 18644.906775466137, 18757.15592798324, 5927.318358388798, 6093.451589356957, 6104.298005729332, 6124.0, 6138.202033735608, 4451.844185453509, 4567.703099298552, 4611.492735799059, 5991.520678345743, 6535.54251202416, 6407.967960160193, 6785.796426107225, 6787.830304242409, 6788.8302792430095, 6788.830279243034, 6535.281119076898, 6747.291534388867, 6756.49326300527, 6771.864562708743, 6805.183377994623, 6443.355664433566, 6456.838579035515, 6458.547901646886, 6466.094746735461, 6467.644279564622, 21610.459738506663, 21831.672524912137, 22299.55400891989, 22477.775222247896, 22600.095996160133, 2561.4620929604807, 2598.9220323390327, 2673.064427450396, 2698.662667166604, 2760.3927136030043, 13694.246816425093, 13922.0, 14331.42674293027, 14335.924805639514, 14494.202818844959, 2052.2211661433134, 2100.359390385947, 2120.2473122041606, 2128.074287684862, 2182.301663467691, 64408.0, 65823.67088164577, 67433.2288776071, 67474.66262668655, 67583.32416675819, 14664.046836955564, 15295.847041529441, 15296.0, 15298.923505382625, 15301.770473442908, 23714.525709485715, 23773.881130594236, 23994.88002560011, 24044.278671639528, 24057.639135412985, 7874.330681891989, 8229.382796290301, 8286.502809831429, 8359.707410240613, 8365.58172091393, 8079.555624440594, 8092.71675491355, 8109.107998120202, 8157.061937877102, 8170.591470426455, 4403.757793321334, 4574.565416285448, 4720.0, 4788.066327066189, 4824.08342414947, 1888.9149988250563, 1946.6593346164364, 1952.0, 1966.301962803213, 1968.3602829080319, 959.4770849886828, 1058.7723639417409, 1065.1798115451058, 1108.6507750058706, 1136.2898188632105, 17129.22918468672, 17586.12069396525, 17630.559236018944, 17739.911300443415, 18190.636187276446, 1017.8829434614966, 1076.2573824061374, 1119.5350390541262, 1121.5962253588702, 1172.9237599556002, 10101.797964040825, 10227.386356818615, 10509.84235236472, 10597.41714205726, 10670.0, 391596.0, 540837.0, 560882.0, 566591.0, 576290.0, 66438.66780666163, 67305.32694673089, 71925.0, 74713.0, 77674.6116269415, 1171.37916904041, 1202.5009621007184, 1203.5847632566927, 1205.1804772754435, 1209.4859684633996, 16124.758128627846, 16147.838521614634, 16221.72590049904, 16516.256768445208, 16720.0, 26534.734652653227, 32169.839150804095, 33007.0, 34418.48372274468, 36497.90506284816, 41938.0, 42837.785811070746, 43363.349549756145, 44641.33038004368, 47073.764631178, 7317.5609463432365, 7490.213527579525, 7555.09338879338, 7704.730334438268, 7753.37972962173, 4001.459802926684, 6472.5145614080075, 9116.498592577473, 10068.986202759332, 11786.941065294619, 10060.84908726355, 10269.0, 10417.895821041693, 10476.476176191007, 10742.570297188338, 9848.852267216142, 10301.278910476194, 10304.381737095799, 10317.690469285933, 10742.140628749525, 9666.081722236377, 9704.951475242578, 10013.14888234479, 10135.188866799204, 10851.945740271249, 7381.963090184515, 7471.9626401867645, 7491.73778917757, 7576.924230757621, 7588.8482230356185, 8238.176182381714, 8343.749687509384, 10189.490525473548, 10724.410157441416, 11014.39420831862], "unit": "score", "name": "jquery.html", "value": 9093.382060479249}, {"lowerIsBetter": false, "replicates": [1377.6073818961586, 1511.4407669162408, 1526.0309703338378, 1728.8530474909633, 1874.3814541201405, 7105.715771369146, 7741.380689544837, 7949.602519874004, 7953.960230198841, 7960.681572737083, 7871.960640196791, 7891.408144389179, 7941.0, 7954.761357159295, 7975.322097621709, 2030.5938812237537, 2076.6469700150933, 2343.2033108743026, 2362.492064206195, 2365.325882123595, 2354.682117914077, 2414.553307638084, 2416.2871952773976, 2422.442838147227, 2424.539337525873, 2346.2609278077352, 2352.952940941189, 2386.809055275574, 2389.808815294772, 2391.234804862445, 2372.8694921779297, 2373.027058905849, 2374.976250237493, 2407.6629271901948, 2413.5896897527464, 2393.2939782764124, 2409.554232466999, 2409.771071748181, 2433.8661373624445, 2437.6343548467694, 7817.687292508293, 7825.765227043198, 7831.451798374116, 7843.019622547182, 7854.528728276265, 4747.145513807513, 4846.951530484721, 4866.294387313855, 4893.510648935114, 4894.706317620954, 2958.8224706517676, 3024.2439390152463, 3069.9539506907413, 3075.354175623122, 3075.5232938894505, 961.8893827209821, 973.4354074636693, 983.7491439682907, 1014.9898501014969, 1018.4958445569416, 10944.069754070913, 11081.168912331526, 11094.55621775128, 11099.83350249747, 11104.0, 4250.404943307939, 4321.48142222929, 4378.365137055109, 4380.846670366522, 4391.67062470316, 9132.178103970675, 9230.76923076915, 9231.584578693975, 9239.722808315626, 9244.260459163252, 4977.153883839684, 4980.05378977993, 5010.448850626428, 5016.247562865527, 5019.071471777733, 4593.425821772278, 4626.930596041062, 4634.189016922025, 4636.582707556337, 4640.280756482751, 3312.38720836646, 3358.5633867597544, 3387.5596172497912, 3630.673239408466, 3681.1533347330264, 1078.428432930548, 1079.5304042741275, 1100.1034157161887, 1102.1513434655271, 1134.0304040045642, 1399.0626280392162, 1402.2848347342724, 1448.2107251547932, 1458.5332693538178, 1458.555140682081, 7497.962510187414, 7578.242175782488, 7580.772576822704, 7722.3049925506975, 7760.417968652374, 1195.2051885496048, 1204.0668481926577, 1207.4040812253725, 1208.64949164743, 1209.0629761934572, 6102.359252278447, 6142.907856382158, 6167.691615419211, 6180.505559555225, 6186.0, 9138.954305228432, 9165.54172291396, 9273.026332235153, 9314.068593140631, 9411.623535058658, 9374.5781439834, 9460.101290377403, 9470.337076404585, 9471.621135154655, 9473.147416732527, 7441.627918604048, 7742.612869356397, 7758.3017528422715, 7775.22247775218, 7777.261160189773, 7542.096292927153, 7585.393168546613, 7617.27635874591, 7652.311291983749, 7677.347425468898, 8500.872486912578, 8589.699360522602, 8661.8700719488, 8672.479651220947, 9043.638254469748, 8923.866142007746, 8991.955040224757, 9102.089791020844, 9131.77170570741, 9203.86194207074, 7304.96347518259, 7429.7399591014055, 7433.10802703679, 7435.591042492715, 7447.106347238149, 6955.756548520778, 7021.859562808818, 7535.434842386952, 7716.421268405004, 7716.961415192888, 7222.621758760023, 7457.552546847207, 7493.250674932463, 7506.3244308012545, 7508.2867127622785, 7375.225601311785, 7404.222556631476, 7404.518706284074, 7472.8879066815125, 7513.887291690519, 7322.633868306457, 7428.73999410018, 7432.145303290191, 7453.0, 7459.738909138154, 6697.966510167418, 6728.529002969745, 6731.966340168267, 6735.4611631070375, 6739.157605299338, 6761.797146085625, 6853.965730171317, 6895.793126206222, 6905.827354316182, 6907.723691052302], "unit": "score", "name": "mootools.html", "value": 4654.8437855464945}, {"lowerIsBetter": false, "replicates": [335.9697627213551, 339.2367173858818, 343.3048077642773, 346.5339118885099, 346.674126321258, 5992.520598352132, 6055.0, 6056.3338032816355, 6061.9696901515545, 6087.695615219238, 5968.582199246054, 5977.671228082454, 5979.342272350038, 5982.940170598293, 5989.071693887455, 4552.203364411214, 4616.907661846761, 4617.69984950978, 4623.930641040387, 4632.884177895546, 4605.37827393301, 4621.0757848430285, 4623.8150473981, 4625.629949604024, 4640.048789998043, 4555.954440455603, 4583.243764778807, 4589.0821835633005, 4590.609798167143, 4594.47163576188, 4382.561743825624, 4475.619572336355, 4512.571305725951, 4565.840195593155, 4589.793459294323, 3960.0891794887048, 3977.0455090778296, 3978.3236849735613, 3989.6409323161056, 3990.3216453203027, 5596.972015139939, 5604.579656525777, 5605.7197140142825, 5615.354234263071, 5617.0731829248125, 5053.418856831475, 5130.384353877558, 5209.2446595243855, 5261.5264626183825, 5264.92102618461, 6240.656763877985, 6244.375562443719, 6245.406686364788, 6252.437280644718, 6259.843503912393, 4417.51407345195, 4459.777011149462, 4464.062546865162, 4465.888352791174, 4465.910681786346, 6420.325865784119, 6574.9013764794045, 6576.835579110512, 6582.506312026617, 6587.011948207759, 4541.386912766734, 4543.54564543543, 4545.545445455494, 4548.522405147478, 4554.339620754972, 4598.471175814757, 4611.146937816515, 4612.584867361954, 4614.0310534787395, 4622.14490319292, 5284.39229488606, 5292.682439053669, 5298.284731561267, 5303.0, 5319.2021196820015, 6218.160548325918, 6346.0, 6444.8388790280615, 6445.484361251089, 6456.7740129095255, 1596.9041857488587, 1621.1569983608458, 1621.7405215165752, 1621.764844097623, 1623.2938671677857, 1063.122923588043, 1076.5586109694987, 1077.0199118801852, 1092.251807511857, 1096.923215374932, 6099.0, 6101.481374083164, 6113.694315284218, 6117.602355846856, 6119.173911521888, 6566.0479230512265, 6568.310327415553, 6571.474282057424, 6578.243501997332, 6586.37429444202, 5984.820455386258, 6093.512518998469, 6111.694415279308, 6113.23584551931, 6142.232220972379, 3527.876524321636, 3556.608773034964, 3560.2523470071574, 3560.786352818839, 3561.1631266652316, 6748.7300507979135, 6750.763723269662, 6760.0535924970545, 6761.797146085625, 6771.627560484122, 6633.535652504278, 6712.865742685119, 6748.797536073926, 6759.831004224835, 6771.559848609824, 6805.251422343538, 6825.590464572141, 6836.0, 6836.418904393182, 6846.931530684629, 6620.172478440195, 6620.702068407029, 6623.768168114093, 6629.502787291069, 6629.701663425061, 6385.106085148176, 6537.738490460329, 6541.574797638138, 6543.116679248241, 6546.083548303146, 6808.931910681028, 6819.727210911508, 6821.045053692586, 6824.556403833735, 6827.419669328163, 4503.684742068024, 4509.639228861749, 4512.751798651106, 4514.525974772601, 4515.051839113823, 6473.935260647333, 6628.602283862983, 6638.50211234169, 6638.668066596748, 6679.8664026718225, 6389.201349831271, 6403.615783053032, 6406.615603063831, 6408.1349017881985, 6425.58233714807, 6439.0, 6444.8388790280615, 6448.290688024407, 6454.903176452451, 6463.289038205699, 6258.179773379939, 6338.968305158444, 6340.175777149126, 6351.2696039956, 6363.077353783583, 6469.7412103515335, 6477.838054048498, 6479.643619600967, 6480.25477070143, 6488.480921526361, 6291.402316779899, 6315.147455093687, 6315.3053164152825, 6318.178636777189, 6324.367563243639], "unit": "score", "name": "prototype.html", "value": 4810.409928408299}, {"lowerIsBetter": false, "replicates": [862.9913700862992, 952.957116929738, 953.2183609440261, 954.4607296877264, 974.0892265731537, 14520.41918323267, 14613.853861461408, 14640.121592704445, 14662.0, 14767.187804670752, 14149.151050936925, 14208.0, 14234.074785138959, 14238.359273832677, 14240.928795356034, 729.2598013016792, 847.0343808058818, 885.7209978856639, 889.7864512516982, 891.2602539891874, 743.5501521579448, 902.7066203483894, 922.0088404964656, 924.6024209589874, 925.2413021322518, 935.0415823780645, 946.9725347997431, 947.3510645208055, 948.6205517792904, 948.8197242523898, 753.9886901696451, 767.5049593012476, 936.2182577547755, 944.1832814615343, 945.0643862576035, 695.5791745993652, 699.2378307644641, 699.9930000699978, 700.2192555300854, 700.4851434195862, 14662.853371466363, 14665.780013299809, 14691.338889749986, 14724.0, 14759.409623615149, 14040.71918561623, 14165.575032749033, 14201.289935503184, 14362.497312594009, 14406.639834004129, 11634.418279086096, 11759.235649682743, 11848.34834084125, 11973.640790776291, 12227.266364018098, 3939.72421930465, 3942.664873485757, 3967.02807812085, 3980.5223373195113, 4097.467329247209, 51462.22806657903, 51599.226011609484, 52010.0, 52412.21381679278, 53745.731271343786, 10683.14534837211, 10688.893111068945, 10751.569937202425, 10820.188485863591, 10889.673309800719, 19076.523086922938, 19260.711089333672, 19307.80692193088, 19335.0, 19341.4197574073, 8102.884329467784, 8249.958750206211, 8287.088420273765, 8376.790580235544, 8407.495550267004, 4714.316424118552, 4715.528447155257, 4716.834910778106, 4742.0, 4787.048567870485, 3346.9497957530657, 3383.1034775784437, 3387.187075101958, 3387.508811222359, 3389.881354152642, 622.0824284180798, 626.0452809465602, 632.7405763636979, 634.058423241486, 636.0713358496554, 644.5778015399827, 705.7670968580356, 706.6961206681176, 716.7204790131852, 769.8806684963839, 8459.238668519863, 8799.868001979976, 9178.954105229432, 9283.76790580241, 9907.950460247797, 527.4804317747016, 738.0700317599756, 750.512167091395, 753.3746989998289, 761.950473219239, 4213.53651098385, 4348.173846969065, 4409.228385032607, 4470.284754439274, 4625.560571745679, 55477.0, 59783.70108149431, 60060.39939600635, 60476.0, 60563.0, 52627.73686131545, 53109.46890531122, 53185.73407133017, 53189.468105318454, 53278.46721532813, 48445.27332090022, 48679.756601216766, 48766.75616621894, 49345.753271233414, 49402.258966114816, 9171.770705732144, 9229.49237791928, 9554.952225238829, 9800.159077351193, 9934.155596774355, 33939.49090763591, 34197.65802341945, 35137.8243108793, 35269.647303527665, 35676.0, 47495.28757068716, 47561.286580702006, 47940.520594793605, 48908.75545622249, 49420.258696118864, 12564.560240391542, 12619.0, 12700.491980320683, 12783.61649150527, 12813.93593032029, 12766.553170639354, 12795.168314059556, 12822.679433013876, 12851.678708032374, 13505.459781609019, 12124.93937530342, 12343.506259749509, 12918.806217906551, 12979.870201297867, 13160.210387376788, 12204.572839950559, 12606.873931260938, 12650.557230496888, 12683.175593586388, 12713.36433178356, 12255.142140050111, 12270.386480675752, 12302.0, 12312.876871231172, 12314.753704925672, 10290.691279261635, 10481.161507079263, 10485.423301718478, 10528.526216320437, 10530.947345263225, 10460.110890574386, 10575.576976920836, 10621.203409744145, 10665.0, 10693.518791654238], "unit": "score", "name": "yui.html", "value": 6871.304382617402}], "name": "dromaeo_css", "value": 7263.136396009383}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 109.0, 109.0, 111.0, 110.0, 111.0, 100.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [159.0, 125.0, 149.0, 161.0, 126.0, 149.0, 147.0, 127.0, 160.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 161.0, 161.0, 159.0, 160.0, 159.0, 158.0], "unit": "score", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 152.0, 72.0, 74.0, 76.0, 73.0, 167.0, 72.0], "unit": "score", "name": "audio-fft", "value": 90.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 95.0, 95.0, 94.0, 150.0, 94.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 58.0, 55.0, 56.0, 56.0, 55.0, 55.0, 58.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 68.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 88.0, 81.0, 83.0, 82.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 114.0, 111.0, 116.0, 118.0, 125.0, 110.0, 111.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 138.0, 137.0, 137.0, 138.0, 136.0, 136.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1484.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [171.76228100309172], "unit": "score", "name": "DeltaBlue", "value": 384.9389960000001}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1009.0817356205853], "unit": "score", "name": "RayTrace", "value": 733.3290990000002}, {"lowerIsBetter": false, "replicates": [572.737686139748], "unit": "score", "name": "Earley", "value": 1163.6443979999995}, {"lowerIsBetter": false, "replicates": [11021.978021978022], "unit": "score", "name": "Boyer", "value": 60.46673280159525}, {"lowerIsBetter": false, "replicates": [40940.0], "unit": "score", "name": "RegExp", "value": 22.251709819247683}, {"lowerIsBetter": false, "replicates": [494.80455220188026], "unit": "score", "name": "Splay", "value": 164.69331099999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21801.042732534723}]} 09:34:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21801.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1484.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7263.13"}}} 09:34:56 INFO - Return code: 0 09:34:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:34:56 INFO - # TBPL SUCCESS # 09:34:56 INFO - Running post-action listener: _resource_record_post_action 09:34:56 INFO - Running post-run listener: _resource_record_post_run 09:34:57 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 598016; Write bytes: 258605056; Read time: 308; Write time: 161052 09:34:57 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1179648; Read time: 0; Write time: 40 09:34:57 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 598016; Write bytes: 257425408; Read time: 308; Write time: 161012 09:34:57 INFO - Running post-run listener: _upload_blobber_files 09:34:57 INFO - Blob upload gear active. 09:34:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:34:57 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 09:34:57 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:34:57 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:34:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:59 INFO - (blobuploader) - INFO - Done attempting. 09:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:34:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:59 INFO - (blobuploader) - INFO - Done attempting. 09:34:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:59 INFO - Return code: 0 09:34:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:34:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf0f216468a18acc80249635fd5dd43e8cdcc3d1e347dd04ec90734894ba6725b35fbf8811cece27b698ffd0f34245cfae44783ffb8e4a4882de6a22361762b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/420f49e06b618f8b63189abb0f7cc55114ec6125c7eb631ef5b8be1b16517b00a7d7dce370ebc7561cc88027640bdd04c2ec0055c4ddb3d8b05dbb73dd66faef"} 09:34:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:34:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:34:59 INFO - Contents: 09:34:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf0f216468a18acc80249635fd5dd43e8cdcc3d1e347dd04ec90734894ba6725b35fbf8811cece27b698ffd0f34245cfae44783ffb8e4a4882de6a22361762b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/420f49e06b618f8b63189abb0f7cc55114ec6125c7eb631ef5b8be1b16517b00a7d7dce370ebc7561cc88027640bdd04c2ec0055c4ddb3d8b05dbb73dd66faef"} 09:34:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:59 INFO - Copying logs to upload dir... 09:34:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:34:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.475648 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-26 09:34:59.907624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:34:59.914996) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf0f216468a18acc80249635fd5dd43e8cdcc3d1e347dd04ec90734894ba6725b35fbf8811cece27b698ffd0f34245cfae44783ffb8e4a4882de6a22361762b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/420f49e06b618f8b63189abb0f7cc55114ec6125c7eb631ef5b8be1b16517b00a7d7dce370ebc7561cc88027640bdd04c2ec0055c4ddb3d8b05dbb73dd66faef"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf0f216468a18acc80249635fd5dd43e8cdcc3d1e347dd04ec90734894ba6725b35fbf8811cece27b698ffd0f34245cfae44783ffb8e4a4882de6a22361762b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/420f49e06b618f8b63189abb0f7cc55114ec6125c7eb631ef5b8be1b16517b00a7d7dce370ebc7561cc88027640bdd04c2ec0055c4ddb3d8b05dbb73dd66faef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:34:59.939149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:34:59.939484) ========= 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=82e07478c745e68b1fe4678a000001bc-1453828436.687312-1921312841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:34:59.989235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:34:59.989571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:34:59.989874) ========= ========= Total master_lag: 0.25 =========