builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1453828471.78 results: success (0) buildid: 20160126091107 builduid: 60ebeafeca9948c99d64a6e6679a355d revision: b9a803752a2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.783397) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.783910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.784220) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004332 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.817984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.818274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.837252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.837556) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.045596 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.892348) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.892658) ========= 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:14:31.893058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:31.893343) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 09:14:31-- 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% 14.9M=0.001s 2016-01-26 09:14:32 (14.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.047746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.048067) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.146917 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.206809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.207181) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 09:14:32,257 Setting DEBUG logging. 2016-01-26 09:14:32,257 attempt 1/10 2016-01-26 09:14:32,257 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:32,507 unpacking tar archive at: mozilla-aurora-b9a803752a2c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618804 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.838863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.839219) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b9a803752a2c program finished with exit code 0 elapsedTime=0.004454 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:32.890279) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.890663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 09:14:32.900285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-26 09:14:32.900603) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:14:33 INFO - MultiFileLogger online at 20160126 09:14:33 in /builds/slave/test-pgo 09:14:33 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:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:14:33 INFO - {'append_to_log': False, 09:14:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:14:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:14:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:14:33 INFO - 'branch': 'Mozilla-Aurora', 09:14:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:14:33 INFO - 'config_files': ('talos/linux_config.py',), 09:14:33 INFO - 'default_actions': ('clobber', 09:14:33 INFO - 'read-buildbot-config', 09:14:33 INFO - 'download-and-extract', 09:14:33 INFO - 'populate-webroot', 09:14:33 INFO - 'create-virtualenv', 09:14:33 INFO - 'install', 09:14:33 INFO - 'run-tests'), 09:14:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:14:33 INFO - 'download_minidump_stackwalk': True, 09:14:33 INFO - 'download_symbols': 'ondemand', 09:14:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:14:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:14:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:14:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:14:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:14:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:14:33 INFO - 'installer_path': 'installer.exe', 09:14:33 INFO - 'log_level': 'info', 09:14:33 INFO - 'log_name': 'talos', 09:14:33 INFO - 'log_to_console': True, 09:14:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:14:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:14:33 INFO - 'opt_config_files': (), 09:14:33 INFO - 'pip_index': False, 09:14:33 INFO - 'sps_profile': False, 09:14:33 INFO - 'sps_profile_interval': 0, 09:14:33 INFO - 'suite': 'dromaeojs', 09:14:33 INFO - 'system_bits': '32', 09:14:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:14:33 INFO - 'title': 'talos-linux64-ix-049', 09:14:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:14:33 INFO - 'use_talos_json': True, 09:14:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:14:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:14:33 INFO - 'work_dir': 'build'} 09:14:33 INFO - ##### 09:14:33 INFO - ##### Running clobber step. 09:14:33 INFO - ##### 09:14:33 INFO - Running pre-action listener: _resource_record_pre_action 09:14:33 INFO - Running main action method: clobber 09:14:33 INFO - rmtree: /builds/slave/test-pgo/build 09:14:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:14:39 INFO - Running post-action listener: _resource_record_post_action 09:14:39 INFO - ##### 09:14:39 INFO - ##### Running read-buildbot-config step. 09:14:39 INFO - ##### 09:14:39 INFO - Running pre-action listener: _resource_record_pre_action 09:14:39 INFO - Running main action method: read_buildbot_config 09:14:39 INFO - Using buildbot properties: 09:14:39 INFO - { 09:14:39 INFO - "project": "", 09:14:39 INFO - "product": "firefox", 09:14:39 INFO - "script_repo_revision": "production", 09:14:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:14:39 INFO - "repository": "", 09:14:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:14:39 INFO - "buildid": "20160126091107", 09:14:39 INFO - "stage_platform": "linux64-pgo", 09:14:39 INFO - "basedir": "/builds/slave/test-pgo", 09:14:39 INFO - "buildnumber": 226, 09:14:39 INFO - "platform": "ubuntu64_hw", 09:14:39 INFO - "mozci_request": { 09:14:39 INFO - "priority": -1, 09:14:39 INFO - "type": "trigger_all_talos_jobs", 09:14:39 INFO - "times": 6 09:14:39 INFO - }, 09:14:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:14:39 INFO - "slavebuilddir": "test", 09:14:39 INFO - "branch": "mozilla-aurora", 09:14:39 INFO - "revision": "b9a803752a2c", 09:14:39 INFO - "slavename": "talos-linux64-ix-049", 09:14:39 INFO - "builduid": "60ebeafeca9948c99d64a6e6679a355d", 09:14:39 INFO - "repo_path": "releases/mozilla-aurora" 09:14:39 INFO - } 09:14:39 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:39 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json. 09:14:39 INFO - Running post-action listener: _resource_record_post_action 09:14:39 INFO - ##### 09:14:39 INFO - ##### Running download-and-extract step. 09:14:39 INFO - ##### 09:14:39 INFO - Running pre-action listener: _resource_record_pre_action 09:14:39 INFO - Running main action method: download_and_extract 09:14:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-linux64/1453731398/test_packages.json 09:14:39 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:39 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:39 INFO - Downloaded 1448 bytes. 09:14:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:14:39 INFO - Using the following test package requirements: 09:14:39 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:39 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:14:39 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:14:39 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'jsshell-linux-x86_64.zip'], 09:14:39 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:14:39 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:39 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:14:39 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:14:39 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:14:39 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:14:39 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:14:39 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:14:39 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:39 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:39 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:39 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:39 INFO - Downloaded 22398026 bytes. 09:14:39 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:39 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:41 INFO - Return code: 0 09:14:41 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:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:41 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:41 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:41 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:41 INFO - Downloaded 22398026 bytes. 09:14:41 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:41 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:43 INFO - Return code: 0 09:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:43 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:43 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:43 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:43 INFO - Downloaded 10706572 bytes. 09:14:43 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:43 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:43 INFO - Return code: 0 09:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:43 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:43 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:43 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:44 INFO - Downloaded 59570039 bytes. 09:14:44 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:44 INFO - mkdir: /builds/slave/test-pgo/properties 09:14:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:14:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:14:44 INFO - Contents: 09:14:44 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:44 INFO - Running post-action listener: _resource_record_post_action 09:14:44 INFO - Running post-action listener: set_extra_try_arguments 09:14:44 INFO - ##### 09:14:44 INFO - ##### Running populate-webroot step. 09:14:44 INFO - ##### 09:14:44 INFO - Running pre-action listener: _resource_record_pre_action 09:14:44 INFO - Running main action method: populate_webroot 09:14:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:14:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:14:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:14:44 INFO - '--tppagecycles', 09:14:44 INFO - '7'], 09:14:44 INFO - 'tests': ['tsvgm']}}, 09:14:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:14:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:14:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:14:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:14:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:14:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'tests': ['damp', 'tps']}, 09:14:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['damp', 'tps']}, 09:14:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:14:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:14:44 INFO - 'other': {'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'other_l64': {'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'other_nol64': {'tests': ['a11yr', 09:14:44 INFO - 'ts_paint', 09:14:44 INFO - 'tpaint', 09:14:44 INFO - 'sessionrestore', 09:14:44 INFO - 'sessionrestore_no_auto_restore']}, 09:14:44 INFO - 'svgr': {'tests': ['tsvgx', 09:14:44 INFO - 'tsvgr_opacity', 09:14:44 INFO - 'tart', 09:14:44 INFO - 'tscrollx', 09:14:44 INFO - 'cart']}, 09:14:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['tsvgx', 09:14:44 INFO - 'tsvgr_opacity', 09:14:44 INFO - 'tart', 09:14:44 INFO - 'tscrollx', 09:14:44 INFO - 'cart']}, 09:14:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'tests': ['tp5o']}, 09:14:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'talos_options': ['--e10s'], 09:14:44 INFO - 'tests': ['tp5o']}, 09:14:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'talos_options': ['--xperf_path', 09:14:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:44 INFO - 'tests': ['tp5n']}, 09:14:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:14:44 INFO - 'talos_options': ['--e10s', 09:14:44 INFO - '--xperf_path', 09:14:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:14:44 INFO - 'tests': ['tp5n']}}, 09:14:44 INFO - 'talos.zip': {'path': '', 09:14:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:14:44 INFO - Running post-action listener: _resource_record_post_action 09:14:44 INFO - ##### 09:14:44 INFO - ##### Running create-virtualenv step. 09:14:44 INFO - ##### 09:14:44 INFO - Running pre-action listener: _resource_record_pre_action 09:14:44 INFO - Running main action method: create_virtualenv 09:14:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:14:44 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:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:14:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:14:44 INFO - Using real prefix '/usr' 09:14:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:14:52 INFO - Installing pip.................done. 09:14:52 INFO - Return code: 0 09:14:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:52 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 09:14:52 INFO - 'HOME': '/home/cltbld', 09:14:52 INFO - 'LANG': 'en_US.UTF-8', 09:14:52 INFO - 'LANGUAGE': 'en_US:en', 09:14:52 INFO - 'LOGNAME': 'cltbld', 09:14:52 INFO - 'MAIL': '/var/mail/cltbld', 09:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:52 INFO - 'MOZ_NO_REMOTE': '1', 09:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:52 INFO - 'NO_EM_RESTART': '1', 09:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:52 INFO - 'SHELL': '/bin/bash', 09:14:52 INFO - 'SHLVL': '1', 09:14:52 INFO - 'TERM': 'linux', 09:14:52 INFO - 'TMOUT': '86400', 09:14:52 INFO - 'USER': 'cltbld', 09:14:52 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:52 INFO - '_': '/tools/buildbot/bin/python'} 09:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:52 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:52 INFO - Cleaning up... 09:14:52 INFO - Return code: 0 09:14:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:52 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 09:14:52 INFO - 'HOME': '/home/cltbld', 09:14:52 INFO - 'LANG': 'en_US.UTF-8', 09:14:52 INFO - 'LANGUAGE': 'en_US:en', 09:14:52 INFO - 'LOGNAME': 'cltbld', 09:14:52 INFO - 'MAIL': '/var/mail/cltbld', 09:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:52 INFO - 'MOZ_NO_REMOTE': '1', 09:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:52 INFO - 'NO_EM_RESTART': '1', 09:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:52 INFO - 'SHELL': '/bin/bash', 09:14:52 INFO - 'SHLVL': '1', 09:14:52 INFO - 'TERM': 'linux', 09:14:52 INFO - 'TMOUT': '86400', 09:14:52 INFO - 'USER': 'cltbld', 09:14:52 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:52 INFO - '_': '/tools/buildbot/bin/python'} 09:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:52 INFO - Downloading/unpacking psutil>=0.7.1 09:14:52 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:52 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:52 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:52 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:52 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:52 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:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:54 INFO - Installing collected packages: psutil 09:14:54 INFO - Running setup.py install for psutil 09:14:54 INFO - building 'psutil._psutil_linux' extension 09:14:54 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:56 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:56 INFO - building 'psutil._psutil_posix' extension 09:14:56 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:56 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:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:14:56 INFO - Successfully installed psutil 09:14:56 INFO - Cleaning up... 09:14:56 INFO - Return code: 0 09:14:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:57 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:57 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:57 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:57 INFO - Using env: {'DISPLAY': ':0', 09:14:57 INFO - 'HOME': '/home/cltbld', 09:14:57 INFO - 'LANG': 'en_US.UTF-8', 09:14:57 INFO - 'LANGUAGE': 'en_US:en', 09:14:57 INFO - 'LOGNAME': 'cltbld', 09:14:57 INFO - 'MAIL': '/var/mail/cltbld', 09:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:57 INFO - 'MOZ_NO_REMOTE': '1', 09:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:57 INFO - 'NO_EM_RESTART': '1', 09:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:57 INFO - 'SHELL': '/bin/bash', 09:14:57 INFO - 'SHLVL': '1', 09:14:57 INFO - 'TERM': 'linux', 09:14:57 INFO - 'TMOUT': '86400', 09:14:57 INFO - 'USER': 'cltbld', 09:14:57 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:57 INFO - '_': '/tools/buildbot/bin/python'} 09:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:14:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:14:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:14:59 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:59 INFO - Installing collected packages: mozsystemmonitor 09:14:59 INFO - Running setup.py install for mozsystemmonitor 09:14:59 INFO - Successfully installed mozsystemmonitor 09:14:59 INFO - Cleaning up... 09:14:59 INFO - Return code: 0 09:14:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:14:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:59 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 09:14:59 INFO - 'HOME': '/home/cltbld', 09:14:59 INFO - 'LANG': 'en_US.UTF-8', 09:14:59 INFO - 'LANGUAGE': 'en_US:en', 09:14:59 INFO - 'LOGNAME': 'cltbld', 09:14:59 INFO - 'MAIL': '/var/mail/cltbld', 09:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:59 INFO - 'MOZ_NO_REMOTE': '1', 09:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:59 INFO - 'NO_EM_RESTART': '1', 09:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:14:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:14:59 INFO - 'SHELL': '/bin/bash', 09:14:59 INFO - 'SHLVL': '1', 09:14:59 INFO - 'TERM': 'linux', 09:14:59 INFO - 'TMOUT': '86400', 09:14:59 INFO - 'USER': 'cltbld', 09:14:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:59 INFO - '_': '/tools/buildbot/bin/python'} 09:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:14:59 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:59 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:59 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:59 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:59 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:59 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:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:15:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:01 INFO - Downloading docopt-0.6.1.tar.gz 09:15:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:02 INFO - Running setup.py install for blobuploader 09:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:15:02 INFO - Running setup.py install for requests 09:15:02 INFO - Running setup.py install for docopt 09:15:02 INFO - Successfully installed blobuploader requests docopt 09:15:02 INFO - Cleaning up... 09:15:02 INFO - Return code: 0 09:15:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:15: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:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:02 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:15:02 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:15:02 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:15:02 INFO - Using env: {'DISPLAY': ':0', 09:15:02 INFO - 'HOME': '/home/cltbld', 09:15:02 INFO - 'LANG': 'en_US.UTF-8', 09:15:02 INFO - 'LANGUAGE': 'en_US:en', 09:15:02 INFO - 'LOGNAME': 'cltbld', 09:15:02 INFO - 'MAIL': '/var/mail/cltbld', 09:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:02 INFO - 'MOZ_NO_REMOTE': '1', 09:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:02 INFO - 'NO_EM_RESTART': '1', 09:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:02 INFO - 'SHELL': '/bin/bash', 09:15:02 INFO - 'SHLVL': '1', 09:15:02 INFO - 'TERM': 'linux', 09:15:02 INFO - 'TMOUT': '86400', 09:15:02 INFO - 'USER': 'cltbld', 09:15:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:02 INFO - '_': '/tools/buildbot/bin/python'} 09:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:15:02 INFO - Running setup.py (path:/tmp/pip-g5G6ti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:15:02 INFO - Running setup.py (path:/tmp/pip-U2uEp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:15:03 INFO - Running setup.py (path:/tmp/pip-wvAJUC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:15:03 INFO - Running setup.py (path:/tmp/pip-e2rkQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:15:03 INFO - Running setup.py (path:/tmp/pip-Bsc7LZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:15:03 INFO - Running setup.py (path:/tmp/pip-EftHAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:15:03 INFO - Running setup.py (path:/tmp/pip-E_lZAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:15:03 INFO - Running setup.py (path:/tmp/pip-QUKMQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:15:03 INFO - Running setup.py (path:/tmp/pip-rnqwKG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:15:03 INFO - Running setup.py (path:/tmp/pip-mv17dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:15:03 INFO - Running setup.py (path:/tmp/pip-Lib3rJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:15:03 INFO - Running setup.py (path:/tmp/pip-ztGmFc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:15:03 INFO - Running setup.py (path:/tmp/pip-qsbbt_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:15:03 INFO - Running setup.py (path:/tmp/pip-YyV72J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:15:03 INFO - Running setup.py (path:/tmp/pip-KFXme4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:15:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:15:03 INFO - Running setup.py (path:/tmp/pip-c0YNGA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:15:04 INFO - Running setup.py (path:/tmp/pip-oFgs8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:15:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:04 INFO - Running setup.py install for manifestparser 09:15:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Running setup.py install for mozcrash 09:15:04 INFO - Running setup.py install for mozdebug 09:15:04 INFO - Running setup.py install for mozdevice 09:15:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Running setup.py install for mozfile 09:15:04 INFO - Running setup.py install for mozhttpd 09:15:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Running setup.py install for mozinfo 09:15:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Running setup.py install for mozInstall 09:15:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:15:04 INFO - Running setup.py install for mozleak 09:15:04 INFO - Running setup.py install for mozlog 09:15:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Running setup.py install for moznetwork 09:15:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Running setup.py install for mozprocess 09:15:05 INFO - Running setup.py install for mozprofile 09:15:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Running setup.py install for mozrunner 09:15:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Running setup.py install for mozscreenshot 09:15:05 INFO - Running setup.py install for moztest 09:15:05 INFO - Running setup.py install for mozversion 09:15:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:15:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:05 INFO - Cleaning up... 09:15:05 INFO - Return code: 0 09:15:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:15: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:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:05 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:15:05 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:15:05 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:15:05 INFO - Using env: {'DISPLAY': ':0', 09:15:05 INFO - 'HOME': '/home/cltbld', 09:15:05 INFO - 'LANG': 'en_US.UTF-8', 09:15:05 INFO - 'LANGUAGE': 'en_US:en', 09:15:05 INFO - 'LOGNAME': 'cltbld', 09:15:05 INFO - 'MAIL': '/var/mail/cltbld', 09:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:05 INFO - 'MOZ_NO_REMOTE': '1', 09:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:05 INFO - 'NO_EM_RESTART': '1', 09:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:05 INFO - 'SHELL': '/bin/bash', 09:15:05 INFO - 'SHLVL': '1', 09:15:05 INFO - 'TERM': 'linux', 09:15:05 INFO - 'TMOUT': '86400', 09:15:05 INFO - 'USER': 'cltbld', 09:15:05 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:05 INFO - '_': '/tools/buildbot/bin/python'} 09:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:15:06 INFO - Running setup.py (path:/tmp/pip-1HNfsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:15:06 INFO - Running setup.py (path:/tmp/pip-WBDb4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:15:06 INFO - Running setup.py (path:/tmp/pip-TMmq37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:15:06 INFO - Running setup.py (path:/tmp/pip-FrIvMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:15:06 INFO - Running setup.py (path:/tmp/pip-RcPXID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:15:06 INFO - Running setup.py (path:/tmp/pip-vyft_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:15:06 INFO - Running setup.py (path:/tmp/pip-Nc6cgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:15:06 INFO - Running setup.py (path:/tmp/pip-ZL0Cbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:15:06 INFO - Running setup.py (path:/tmp/pip-BUk9Wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:15:06 INFO - Running setup.py (path:/tmp/pip-2y9GpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:15:06 INFO - Running setup.py (path:/tmp/pip-5Y89FJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:15:06 INFO - Running setup.py (path:/tmp/pip-uYc3uQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:15:06 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:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:15:06 INFO - Running setup.py (path:/tmp/pip-5Wpfl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:15:07 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:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:15:07 INFO - Running setup.py (path:/tmp/pip-8CDO2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:15:07 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:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:15:07 INFO - Running setup.py (path:/tmp/pip-cQDxGm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:15:07 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:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:15:07 INFO - Running setup.py (path:/tmp/pip-ZhtKkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:15:07 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:15:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:15:07 INFO - Running setup.py (path:/tmp/pip-P2M7Ln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:07 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:15:09 INFO - Downloading blessings-1.6.tar.gz 09:15:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:09 INFO - Installing collected packages: blessings 09:15:09 INFO - Running setup.py install for blessings 09:15:09 INFO - Successfully installed blessings 09:15:09 INFO - Cleaning up... 09:15:09 INFO - Return code: 0 09:15:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:15:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:15:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:15:09 INFO - Reading from file tmpfile_stdout 09:15:09 INFO - Current package versions: 09:15:09 INFO - argparse == 1.2.1 09:15:09 INFO - blessings == 1.6 09:15:09 INFO - blobuploader == 1.2.4 09:15:09 INFO - docopt == 0.6.1 09:15:09 INFO - manifestparser == 1.1 09:15:09 INFO - mozInstall == 1.12 09:15:09 INFO - mozcrash == 0.16 09:15:09 INFO - mozdebug == 0.1 09:15:09 INFO - mozdevice == 0.48 09:15:09 INFO - mozfile == 1.2 09:15:09 INFO - mozhttpd == 0.7 09:15:09 INFO - mozinfo == 0.9 09:15:09 INFO - mozleak == 0.1 09:15:09 INFO - mozlog == 3.1 09:15:09 INFO - moznetwork == 0.27 09:15:09 INFO - mozprocess == 0.22 09:15:09 INFO - mozprofile == 0.28 09:15:09 INFO - mozrunner == 6.11 09:15:09 INFO - mozscreenshot == 0.1 09:15:09 INFO - mozsystemmonitor == 0.0 09:15:09 INFO - moztest == 0.7 09:15:09 INFO - mozversion == 1.4 09:15:09 INFO - psutil == 3.1.1 09:15:09 INFO - requests == 1.2.3 09:15:09 INFO - wsgiref == 0.1.2 09:15:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:15: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:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:09 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 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:15:09 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:15:09 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:15:09 INFO - Using env: {'DISPLAY': ':0', 09:15:09 INFO - 'HOME': '/home/cltbld', 09:15:09 INFO - 'LANG': 'en_US.UTF-8', 09:15:09 INFO - 'LANGUAGE': 'en_US:en', 09:15:09 INFO - 'LOGNAME': 'cltbld', 09:15:09 INFO - 'MAIL': '/var/mail/cltbld', 09:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:09 INFO - 'MOZ_NO_REMOTE': '1', 09:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:09 INFO - 'NO_EM_RESTART': '1', 09:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:09 INFO - 'SHELL': '/bin/bash', 09:15:09 INFO - 'SHLVL': '1', 09:15:09 INFO - 'TERM': 'linux', 09:15:09 INFO - 'TMOUT': '86400', 09:15:09 INFO - 'USER': 'cltbld', 09:15:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:09 INFO - '_': '/tools/buildbot/bin/python'} 09:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 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:15:09 INFO - Cleaning up... 09:15:09 INFO - Return code: 0 09:15:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:15: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:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:15: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', 'jsonschema'] in /builds/slave/test-pgo/build 09:15: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 jsonschema 09:15:09 INFO - Using env: {'DISPLAY': ':0', 09:15:09 INFO - 'HOME': '/home/cltbld', 09:15:09 INFO - 'LANG': 'en_US.UTF-8', 09:15:09 INFO - 'LANGUAGE': 'en_US:en', 09:15:09 INFO - 'LOGNAME': 'cltbld', 09:15:09 INFO - 'MAIL': '/var/mail/cltbld', 09:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:09 INFO - 'MOZ_NO_REMOTE': '1', 09:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:09 INFO - 'NO_EM_RESTART': '1', 09:15:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:09 INFO - 'SHELL': '/bin/bash', 09:15:09 INFO - 'SHLVL': '1', 09:15:09 INFO - 'TERM': 'linux', 09:15:09 INFO - 'TMOUT': '86400', 09:15:09 INFO - 'USER': 'cltbld', 09:15:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:09 INFO - '_': '/tools/buildbot/bin/python'} 09:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:10 INFO - Downloading/unpacking jsonschema 09:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:12 INFO - warning: no files found matching '*.txt' 09:15:12 INFO - no previously-included directories found matching 'build' 09:15:12 INFO - no previously-included directories found matching 'dist' 09:15:12 INFO - no previously-included directories found matching '.git*' 09:15:12 INFO - Installing collected packages: jsonschema, functools32 09:15:12 INFO - Running setup.py install for functools32 09:15:12 INFO - warning: no files found matching '*.txt' 09:15:12 INFO - no previously-included directories found matching 'build' 09:15:12 INFO - no previously-included directories found matching 'dist' 09:15:12 INFO - no previously-included directories found matching '.git*' 09:15:12 INFO - Successfully installed jsonschema functools32 09:15:12 INFO - Cleaning up... 09:15:12 INFO - Return code: 0 09:15:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:15: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:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d0eebaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1061230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', '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:15: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', 'flake8'] in /builds/slave/test-pgo/build 09:15: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 flake8 09:15:12 INFO - Using env: {'DISPLAY': ':0', 09:15:12 INFO - 'HOME': '/home/cltbld', 09:15:12 INFO - 'LANG': 'en_US.UTF-8', 09:15:12 INFO - 'LANGUAGE': 'en_US:en', 09:15:12 INFO - 'LOGNAME': 'cltbld', 09:15:12 INFO - 'MAIL': '/var/mail/cltbld', 09:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:12 INFO - 'MOZ_NO_REMOTE': '1', 09:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:12 INFO - 'NO_EM_RESTART': '1', 09:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:12 INFO - 'SHELL': '/bin/bash', 09:15:12 INFO - 'SHLVL': '1', 09:15:12 INFO - 'TERM': 'linux', 09:15:12 INFO - 'TMOUT': '86400', 09:15:12 INFO - 'USER': 'cltbld', 09:15:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:12 INFO - '_': '/tools/buildbot/bin/python'} 09:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:12 INFO - Downloading/unpacking flake8 09:15: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:15: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:15: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:15: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:15: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:15: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:15:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:15:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:15: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:15: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:15: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:15: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:15: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:15: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:15:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:15:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:15: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:15: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:15: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:15: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:15: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:15: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:15:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:15: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:15: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:15: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:15: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:15: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:15: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:15:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:14 INFO - no previously-included directories found matching 'docs/_build' 09:15:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:15:15 INFO - Running setup.py install for pep8 09:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:15:15 INFO - no previously-included directories found matching 'docs/_build' 09:15:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:15:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:15:15 INFO - Cleaning up... 09:15:15 INFO - Return code: 0 09:15:15 INFO - Running post-action listener: _resource_record_post_action 09:15:15 INFO - Running post-action listener: _start_resource_monitoring 09:15:15 INFO - Starting resource monitoring. 09:15:15 INFO - ##### 09:15:15 INFO - ##### Running install step. 09:15:15 INFO - ##### 09:15:15 INFO - Running pre-action listener: _resource_record_pre_action 09:15:15 INFO - Running main action method: install 09:15:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:15:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:15:15 INFO - Reading from file tmpfile_stdout 09:15:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:15:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:15:15 INFO - Reading from file tmpfile_stdout 09:15:15 INFO - Output received: 09:15:15 INFO - Usage: mozinstall [options] installer 09:15:15 INFO - Options: 09:15:15 INFO - -h, --help show this help message and exit 09:15:15 INFO - -d DEST, --destination=DEST 09:15:15 INFO - Directory to install application into. [default: 09:15:15 INFO - "/builds/slave/test-pgo"] 09:15:15 INFO - --app=APP Application being installed. [default: firefox] 09:15:15 INFO - mkdir: /builds/slave/test-pgo/build/application 09:15:15 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:15:15 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:15:30 INFO - Reading from file tmpfile_stdout 09:15:30 INFO - Output received: 09:15:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:15:30 INFO - Running post-action listener: _resource_record_post_action 09:15:30 INFO - ##### 09:15:30 INFO - ##### Running run-tests step. 09:15:30 INFO - ##### 09:15:30 INFO - Running pre-action listener: _resource_record_pre_action 09:15:30 INFO - Running main action method: run_tests 09:15:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:15:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:15:30 INFO - Python 2.7.3 09:15:30 INFO - Return code: 0 09:15:30 INFO - grabbing minidump binary from tooltool 09:15:30 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:15:30 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 0x10f37f0>, '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 0x105f2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:15:30 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:15:30 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:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:15:30 INFO - Return code: 0 09:15:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:15:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:15:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:15:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:15:31 INFO - Return code: 0 09:15:31 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-049', '--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:15:31 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-049 --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:15:31 INFO - Using env: {'DISPLAY': ':0', 09:15:31 INFO - 'HOME': '/home/cltbld', 09:15:31 INFO - 'LANG': 'en_US.UTF-8', 09:15:31 INFO - 'LANGUAGE': 'en_US:en', 09:15:31 INFO - 'LOGNAME': 'cltbld', 09:15:31 INFO - 'MAIL': '/var/mail/cltbld', 09:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:31 INFO - 'MOZ_NO_REMOTE': '1', 09:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:31 INFO - 'NO_EM_RESTART': '1', 09:15:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:15:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:15:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:15:31 INFO - 'SHELL': '/bin/bash', 09:15:31 INFO - 'SHLVL': '1', 09:15:31 INFO - 'TERM': 'linux', 09:15:31 INFO - 'TMOUT': '86400', 09:15:31 INFO - 'USER': 'cltbld', 09:15:31 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615', 09:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:31 INFO - '_': '/tools/buildbot/bin/python'} 09:15:31 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-049', '--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:15:32 INFO - mozversion application_buildid: 20160125061638 09:15:32 INFO - mozversion application_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:15:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:15:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:15:32 INFO - mozversion application_name: Firefox 09:15:32 INFO - mozversion application_remotingname: firefox-dev 09:15:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:15:32 INFO - mozversion application_vendor: Mozilla 09:15:32 INFO - mozversion application_version: 46.0a2 09:15:32 INFO - mozversion platform_buildid: 20160125061638 09:15:32 INFO - mozversion platform_changeset: b9a803752a2cb143582e6665ed3fb679eebf60b3 09:15:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:15:32 INFO - mozversion platform_version: 46.0a2 09:15:32 INFO - using testdate: 1453828532 09:15:32 INFO - actual date: 1453828532 09:15:32 INFO - starting webserver on 'localhost:35497' 09:15:32 INFO - SUITE-START | Running 3 tests 09:15:32 INFO - TEST-START | dromaeo_css 09:15:32 INFO - operating with platform_type : linux_ 09:15:32 INFO - Initialising browser for dromaeo_css test... 09:15:32 INFO - TEST-INFO | started process 3294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdOi8cP/profile http://localhost:35497/getInfo.html) 09:15:37 INFO - PROCESS | 3294 | __metrics Screen width/height:1600/1200 09:15:37 INFO - PROCESS | 3294 | colorDepth:24 09:15:37 INFO - PROCESS | 3294 | Browser inner width/height: 1024/697 09:15:37 INFO - PROCESS | 3294 | __metrics 09:15:37 INFO - PROCESS | 3294 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:38 INFO - TEST-INFO | 3294: exit 0 09:15:38 INFO - Browser initialized. 09:15:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:15:38 INFO - TEST-INFO | started process 3388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdOi8cP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:50 INFO - PROCESS | 3388 | RSS: Main: 136982528 09:15:50 INFO - PROCESS | 3388 | 09:16:41 INFO - PROCESS | 3388 | 1453828601618 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:50 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35497/tests/dromaeo/cssquery-ext.html) 09:18:50 INFO - PROCESS | 3388 | RSS: Main: 237379584 09:18:50 INFO - PROCESS | 3388 | 09:21:53 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-ext.html (next: http://localhost:35497/tests/dromaeo/cssquery-jquery.html) 09:21:53 INFO - PROCESS | 3388 | RSS: Main: 218370048 09:21:53 INFO - PROCESS | 3388 | 09:24:55 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35497/tests/dromaeo/cssquery-mootools.html) 09:24:56 INFO - PROCESS | 3388 | RSS: Main: 217858048 09:24:56 INFO - PROCESS | 3388 | 09:27:58 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35497/tests/dromaeo/cssquery-prototype.html) 09:27:58 INFO - PROCESS | 3388 | RSS: Main: 200503296 09:27:58 INFO - PROCESS | 3388 | 09:31:01 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35497/tests/dromaeo/cssquery-yui.html) 09:31:01 INFO - PROCESS | 3388 | RSS: Main: 199749632 09:31:01 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:35497/tests/dromaeo/cssquery-yui.html (next: http://localhost:35497/tests/dromaeo/cssquery-dojo.html) 09:34:04 INFO - PROCESS | 3388 | RSS: Main: 241065984 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | __start_tp_report 09:34:04 INFO - PROCESS | 3388 | _x_x_mozilla_page_load 09:34:04 INFO - PROCESS | 3388 | _x_x_mozilla_page_load_details 09:34:04 INFO - PROCESS | 3388 | |i|pagename|runs| 09:34:04 INFO - PROCESS | 3388 | |0;dojo.html;3260.869565217391;3300.636929937708;3307.4542700454413;3337.098983274516;3364.2262279675665;5305.681659100456;5312.60155488338;5314.149736042229;5315.309009828722;5361.410244873061;5297.920531192035;5318.282031925689;5331.120365139757;5341.893162136765;5343.278657381253;4682.953170468286;4721.551452611996;4853.514648535153;4864.440589332228;4885.2427873679635;4740.810367585293;4799.472058073609;4806.927896081562;4807.206810876201;4809.158397280479;4764.0471905619015;4811.494793046732;4817.060673168733;4841;4917.72952487613;4909.484504127069;4937.037277730844;4937.164716606136;4938.209886418192;4968.776405061781;4826.831060912851;4866.02679464105;4868.659193856432;4898.755062246909;4907.411110666707;4998.325226094504;5054.267131265946;5128.589712822965;5185.792568297264;5217.5565076968505;5632.971835140839;5655.745491452894;5686.0333743263745;5686.601937864351;5687;5506.972465137689;5700.2589663343915;5727.455891690282;5728.598998070137;5731.684757338345;5286.867828304285;5321.6540924839765;5378.408375078739;5382.838514844561;5383.892322153574;5851.32709738377;5851.561132914963;5854.268216472941;5855.912161317584;5858.150568167592;5415.83752487426;5437;5651.6043876928225;5681.375048744635;5684.573656975744;5686.118651609007;5709.600327977002;5737.3975732548315;5747.655140691572;5785.421457854265;5620.016497112989;5635.126555383922;5647.887042259132;5652.378238393773;5686.317641883001;5487.835364939058;5595.132754423071;5597.496225339739;5673.74468148926;5688.800891968761;4324.956750432519;4336.82652693895;4338.652907767434;4339.175556644227;4342.652587792969;3866.980665096713;3907.27715372657;3916.4516967624554;3921.784301863368;3968.3452230381663;5246.42289348179;5267.499587539178;5268.604854635841;5269.473052694777;5282.075636763551;5639.238702775155;5643.125315576092;5643.887122257532;5653.349864765604;5688.715564221855;5193.948060519422;5233.607479439057;5280.419153893069;5334;5424.05079111154;4925.87685307863;4951.430585482643;4955.083309587738;4962.60299176065;4995.100881841231;5838.211841401441;5850.795222167204;5862.853428664317;5868.325142608569;5871.735771890275;5376.516113549799;5528.170774383714;5646.322441307069;5710.971445142748;5747.971260143672;5859.824205273678;5872.882542349043;5878.29460464747;5883.882322353444;5886.676232807065;5480.972595136999;5658.688772117408;5669.489745922887;5679.148127780701;5681.630694004876;5559.916601251065;5568.6658800472105;5587.720613969204;5614.354349249726;5621.184928185472;5494.450554944474;5495.422980587141;5496.038193316233;5499.50504454601;5499.752511137089;5498.890022199614;5541.667499950016;5552.222688823649;5559.2217089606675;5586.52514536269;5359.678419294854;5467.39858615544;5508.9724551376985;5514.641548299348;5557.972210138923;5462.126059830408;5485.985092757853;5491.231227628055;5500.87232117423;5543.556515478833;5252.1596544552685;5319.38827034896;5345.492178243217;5371.274877891591;5406.513413792777 09:34:04 INFO - PROCESS | 3388 | |1;ext.html;537.5538303208335;540.6699519182815;555.8304717061297;565.4119715495885;580.9977788315157;28785.28036799081;29507.40985180295;29513.40973180535;29523.261918452048;29553.113406597837;38061;38373.42439863397;38513.229735405344;38629.8068509657;38636.80681596595;8641.697540586065;8839.337049721264;8840.160184782435;8848.424852384574;8849.690260840873;8566.871496927552;8718.956405217965;8722.607482663296;8727.127287271285;8736.912630873705;8701.651933922636;8814.86777698335;8815.911840881605;8980.685676001342;9001.324900632446;8847.469151850877;8951.283897288235;8974.192322690924;8974.641014359418;8982.236509896667;8724.738257852274;8819.647214111428;8875.600597973042;8881.955590222007;8883.978342490567;40871.38692919609;41177.382339264936;41354.58645413537;41429.1714165715;41458.585414145775;3828.559715632682;3885.514310711161;3911.9804400977814;4030.294698427793;4501.662375321864;32242.838785806154;32399.352012959607;32417.351652967045;32539.837300813346;32772.6722732772;3944.8816535503693;3959.920801583952;4012.498437695288;4027.6979226558124;4105.91788164235;285402;286637;287213;287734.9999999979;288074;42470.150596988504;42600.14799703989;54559;55234.171487427724;62093.68953155205;61661.69169154126;61862.69068654628;62150.0677489838;62171.37828621746;62176.68911655413;17474.126293685265;17594.64810703779;17635.911820441073;17651.55871103233;17657.911710441367;12023.218490798245;12199.93900030512;13359.732805344032;13778.448862045607;13784.310784460737;10878.238523303451;12470.563530276397;20697.68953465699;20818.167273309202;20850.374488765363;7333.339999400079;7645.025353908735;7666;7784.494007889469;7802.765917022499;1090.4275255490772;1109.6338208391212;1195.1394995603152;1203.8374819399444;1211.8121691137887;30810.69189308078;30823.845880770452;30883;31259.531107033414;31841;1104.872939611955;1137.943102844871;1150.8561429821273;1251.5619533163501;1268.105985280375;13547.729045419233;14297.428102875769;14696.26518674062;15921.522354329389;16643.91678041602;357520;360857;361647;364793;369087;53822;54176.45823541793;54195.729021354644;54216.72891635517;54292.45707542953;1480.8519148085106;1488.5459934720013;1490.8807295416125;1502.646877983673;1502.774583812437;30665.233369165948;30673;30874.69125308718;31120.53319200259;31421.371572568878;47158.29262560996;47411.05177896492;47421.288680669124;47439;47489.05021899612;337529;340554;341048;341095;341132;27629.447411051264;31931.521027184146;32733.672663274014;33172.336553269284;33220.1694957628;39449.40825887671;40002;40428.1914361717;40863.7956810214;41314.58685413108;33743.83128084344;33761;33805.15487112744;34126;34167.145821354665;30973.380532388775;34165.145871353416;35544.28911421809;36847;37046.07384815401;39046.219075618894;39175.608243917195;39528.209435810546;39789.20421591494;40023;30802;31382.529262061544;32033.359332812746;32056.51915221227;32190.19524511906;24970.62544061877;25087.87456062708;25166.49667006613;25206.747932521175;25518.74481255164 09:34:04 INFO - PROCESS | 3388 | |2;jquery.html;385.92474467478837;388.2603640065676;389.1846581411941;393.34508044106565;409.36957086087426;13689.452421903137;15848.20758962053;16423.917880410598;19307.806921930794;19352;16442.177891105457;16810.579735506617;16914.577135571588;18211.180496877638;18757.343492977747;5022.422421421537;5215.269862219292;5230.555402790748;5235.214717792323;5238.345206849144;3879.3792993121106;4029.798510074499;5158.871028224287;5394.7842086316505;5597.188407680884;5532.861678458031;5569.053260945649;5598.720063996784;5599.972000140014;5706.400827913071;5495.258140151069;5841.824745257649;5845.941540584582;5852.795152169653;5883.735231914553;5372.086745253317;5374.8925021499745;5378.1663842104535;5380.838574842761;5382;13033.86966130336;13122.803157952638;13745.38145783442;13899.305034748222;13905.096168749;1985.2257619528395;2162.3080614203304;2239.921602743896;2246.180144247338;2378.3578433822945;10354.792904141876;11628.439909929617;12676.68308292291;13177.802332965013;13858.099223550436;1860.3209828412532;2002.2491565662876;2006.107282259395;2017.404865564662;2028.6652702304102;58693.41306586922;59343.703281483315;60770;61157.38842611561;62763.6861815688;10620.362778233331;10927.781444371069;10967.83548246777;10971.298460063394;11114.722131946604;14006.229657368738;14751;14829.629259268604;14863;14865.851341486663;8041.597920103972;8274.420790544724;8415.326773858076;8444.493330400073;8449.704260350858;8194.385421093442;8271.627776750061;8292.12932642076;8342.332613390914;8363.540005299645;4417.381566580617;4833.984863178702;4834.685745426536;4907.60739140875;4937.703737775745;1835.6604028254815;1907.7043058325983;1936.206155476276;1966.5182030402643;2008.0562135796151;955.4171955107379;1037.7353774787382;1040.375774535288;1115.085629783586;1157.0801213035656;12918.547850825176;16545.66908661844;16920.57698557546;17189.05460199676;17223;1028.717102796722;1035.471909326234;1050.406520316019;1069.1393428290146;1095.2497539185683;9327.300452465957;9699.175570076623;9735;9897.208223342115;10221.284510084372;559565;562208;562966;576026;584510;77339;77470.61264693753;77857.61071194608;79073.60463197762;79641;1257.0697683714168;1257.1137348169518;1257.226805514602;1261.4954018392532;1274.2409890822112;15489.84510154884;15530.9223453882;15623.531294061197;15876;16068;34048.48927266143;34660.30679386348;34969.82515087408;35017.649823502456;35814.820925896245;44919;44967.55032449633;45449.545504544534;45918.31122533098;48457.75771121122;4464.821407143678;5380.493461830693;7172.175199851875;7263.745768898063;7530.887036694345;9669.854952175583;11469;11673.066154707432;11817.113716471471;11879.22785018971;9691.515424228619;9958.950205248928;9977.650782222587;10362.585496580052;10437.478126093816;9638.469884156159;9666.178374838217;9667.661631842851;9856.950715246378;9911.752206194902;8355.289800367036;10199.596411659917;10276.17790576737;10409.323393979366;10627.521761520595;7195.892061618975;7497;7523.699052037857;7590;7611.581363025087;9952.25358098131;10102.79264997637;10226.846597300897;10398.844017339594;10671.626493072705 09:34:04 INFO - PROCESS | 3388 | |3;mootools.html;1423.8504956979523;1552.4411211963693;1574.2915687940426;1800.3698705453085;1926.0851095729522;7139.178994415637;7315.707371705132;7734.342580880618;7883.36933045355;7899.249571290733;7992.720254791069;8007.399445041616;8043.436959412844;8060.5566693831815;8082.353411727063;2036.389083275019;2080.5214800595872;2353.6587194856734;2386.85678859269;2387.6657267982496;2340.625499920013;2415.3961509622595;2422.6608274841537;2423.8303318767694;2425.102711996564;2373.2524254859663;2398.0287983366766;2416.794572461343;2416.9274921752376;2418.359134829263;2371.750966148564;2383.5709572276983;2398.5083057973075;2400.411899084727;2405.3625789165885;2428.672129262545;2432.391902024494;2450.889709963056;2450.938726531851;2451.240115564181;8102.918970810276;8260.339172866155;8264.421490495668;8268.214519620626;8270.172982701743;4805.951940480585;4925.975370123162;4966.255061740731;4967.751612419364;4975.577075948512;3241.38413701396;3255.4953982132806;3256.5929258842643;3272.967270327314;3337.9499307510405;1075.0808059109506;1080.3733834376044;1094.8521949536869;1105.1269497097283;1105.2760441910561;10849.349039057683;11037.227394082418;11106.222564420494;11109.111271098374;11112.222144449972;4382.693211475166;4417.050334178167;4431.135928493977;4497.033137875373;4512.2554778461845;9543.093406126407;9552.904470955202;9571.28215383849;9576.952115239379;9639.132478077006;4860.0765854488245;4908.803647854117;4923.606111511142;4956.405231372259;4960.801567937242;4491;4535.931961020588;4542.341360502709;4556.3393307970155;4556.339330797082;3520.2783429396914;3580.3197392495345;3758.9248215035545;3820.1977584707524;3913.1391093959282;1207.8671346151916;1258.2702032820941;1274.2099898063261;1275.483429211171;1275.515304184404;1197.8862008109215;1209.3892584245075;1217.056780994736;1454.7672372420361;1476.6677497562962;7686.961565192139;7792.649330780128;7794.2985131338455;7798.376129909594;7815;1187;1187.6437068879475;1192.5468322037743;1192.8031874740743;1210.2556927489532;5942.37605051472;6064.727087281083;6081.908771368433;6087.360827113178;6090.543209259324;8995.100489951083;9126.726198214064;9304.116108969638;9433.716988490356;9440.150386465251;9350.438973661601;9355.90644093564;9357.438553686801;9372.297077719199;9378.109079637423;7379.6679149438405;7637.121731000895;7705.961470192613;7723.34351580122;7750.379969602418;7365.852682946418;7708.691652334068;7747.225277472207;7802.921970780447;7809.609519524115;8738.475691458278;8753.737387878375;8858.822823543363;8908.153725396078;9062;9130.726078217664;9155.725328240163;9343.159115679622;9378.062193780841;9391.718248452557;7510.211427800221;7570.280823321776;7655.617219139132;7697.268759467842;7706.152323244327;7045.048918395951;7231.4937954342695;7627.923720762943;7765.961170194113;7817.648205830637;7201.819954501179;7353.889691654523;7354.301341372561;7388.224236455095;7438.814029649302;7205.891911621225;7213.495055346285;7301.963490182515;7317.231690672403;7324.96337518309;7187.820304492429;7334.96332518334;7367.042284502981;7505.962470187614;7515.473916825769;6732.730690772511;6766.966165169143;6776.356246156607;6807.183138023271;6813.250542440427;6929.757458488929;6995.685194166173;6996.825079372853;7042.753503627348;7054.08296921397 09:34:04 INFO - PROCESS | 3388 | |4;prototype.html;356.9482425048368;361.95113659655937;364.46241793354807;365.9469376940344;366.5711117991949;5869.3837147099475;6007.339192688801;6040.395960403968;6043.18417013703;6077.179580756602;5825.8834823303505;6015.9699201504045;6020.066889632103;6066.726997285122;6077.3922607739205;4625.838095666652;4635.860924172263;4638.536146385368;4640.721556706591;4646.72119672819;4464.040231350259;4532.410786597754;4543.568361005699;4558;4634.189016922042;4509.346144809001;4567.223571992769;4664.650151238654;4665.020345727401;4680.25115981443;4620.745858977755;4641.767911604423;4645.651576131803;4649.907001859978;4667.043256132519;4137.482814648169;4142.5028996520305;4142.937855932163;4155.501339839208;4160.188763191179;5675.744591493351;5683.772649094072;5731.856703582402;5750.7412166452195;5750.82747517571;5456.508914197741;5462.918056229159;5466.180072989044;5471.699056551888;5474.698891560963;6003.549733769941;6338.904916426257;6347.301796802348;6350.555461117724;6352.078948552434;4464.553544645542;4466.397036400077;4597.908041839178;4606.262997920317;4616.722996620214;6625.204975402934;6646.435053020499;6649.468042556632;6658.700358483831;6663.167104111986;4716.551927566876;4731.2903064539905;4731.834385796549;4732.574068333866;4734.597559207437;4710.3405523226775;4789.544993225638;4791.520847915251;4792.640551958617;4804.903901921942;5431.5926305526455;5437.211604317352;5438.6736795791585;5448.101063324586;5453.64551304164;6416.679166041679;6421.486281097595;6422.518311126684;6423.903641445382;6425.132607098076;1664.96670066598;1677.2033284190156;1677.387753469999;1679.2779104984975;1681.2686481380395;1105.5798796457295;1114.3536748685742;1115.966521004371;1131.8924702153283;1168.7195073182374;6097.268327800603;6149.354317796657;6157.415045570664;6160.44555989963;6162.414570615874;6413.615183088937;6510.869782604322;6516.934830651728;6593;6604.900926486107;6134.171886795226;6145.446909778141;6145.477634401037;6151.661658608819;6153.384661533811;3526.3123690880034;3560.359135355661;3564.465330200439;3566.4293713005795;3566.7503274771034;6701.29636388182;6738.427233685192;6759.695813688396;6891.242733103027;6903.6203008835;6874.106366172366;6892.724291028403;6893.551919125241;6897.103376561015;6899.862002759916;6879.724811007503;6884.105066341343;6885.449164066863;6890.793276201722;6894.655267236719;6355.205599300088;6460.063290822711;6465.547411681137;6476.481881449378;6714.026466162477;6452.677366131768;6525.2169739631545;6550.934490655223;6568.7372505099265;6569.113169722217;6819.556728812611;6819.89770153458;6823.658817059028;6830.692618832065;6832.077669514552;4617.907641847077;4710.458297295855;4775.95224047769;4795.712257264575;4815.6147508198555;6631.767888123893;6639.3692599203;6640.402363787089;6642.535022548568;6647.302033286435;6429.324920883427;6439.645819479973;6440.13058237132;6441.291457939529;6441.903371449338;6315.652639104894;6362.936370636419;6460.386263305167;6520.445762110274;6522.412982831568;6434.67826608677;6481.740730370921;6481.935180648133;6482.448991835558;6486.837829054311;6504.219493660791;6539.084528165966;6540.705668245036;6542.705578248895;6549.672516374258;6134.7852825152695;6368.968155159195;6373.490120790233;6379.234491861006;6379.87240255183 09:34:04 INFO - PROCESS | 3388 | |5;yui.html;855.3820260871715;856.8414843253998;892.2014796756898;914.0219964637838;957.0812020460357;14377.209253491066;14601.269936503159;14604.050736702107;14620.195889226088;14628.122312661248;13690.589282321545;13731.382087806047;13757.79363309551;13763.862361376383;13779.862201378008;884.2351366068336;904.7828521154909;907.5462268865567;913.8903331600218;916.7295647783886;892.4422236102436;903.2142036428316;903.4940433357341;904.3262769236927;905.3571963905634;944.834653935562;952.057463111518;953.1659797677032;953.3707752883098;960.7021823234785;942.4910548303908;950.1021534649759;951.5813042261417;952.2619969523605;953.3088510829663;702.9051078104493;705.6894966214849;706.0221593093551;706.8126946359218;707.1937990690617;15180.165090919994;15216.847831521654;15230.466933657379;15252.542423727306;15296.770548441782;13784.586462406143;13938.860611393859;13939.16365018102;14027.228502432363;14055.859441405557;11682.94158529202;11712.53149874004;11903.821442678367;12155.209911355734;12344.938275308656;3876.6511014008593;3926.960730392688;3940.310445672025;3950.071733142709;4035.394690796404;45888.77055614734;46158.07683846338;47632.52367476316;51791;54522.727386362814;11066.502007409686;11390.886091139148;11474.48364823585;11482.712932176595;11581.88418115825;16538.338466461446;19026;19047.61904761897;19069.61860762777;19080.904595476935;6969.47728920333;7246.927530724625;7966.322862556632;8052.798680032929;8103.473274237156;4793.281007848851;4835.419749629997;4855.441624213261;4889.877753056202;4947.6536642434685;3290.930447604538;3321.850516726753;3323.5347051412823;3328.4008878401637;3328.9667103329143;606.8300875754795;613.2365205319317;615.1603061820672;622.1476577089417;630.9747610095636;586.2788769813154;652.9813490954127;732.3006528765017;751.3538357012965;756.9583672897934;9598.472084035446;10111.595536178618;10146.543405546769;10260.179185665129;10471.738206544896;695.6938946863364;699.8355386484172;721.9747957899795;738.78205929251;757.0423414380813;4092.4884389451317;4514.187446259639;4522.547745225451;4534.501204867462;4540.432445944257;60383;61645.691771540856;61665.691671542256;61692;61711.691441542505;46387;54001.189982150296;54074;54250;55028;44774.10451790946;46142.30786538205;47141.76429117901;48163.5183648159;48603.75698121558;9627.807443850943;9839.85240221383;9889.901100988898;9899.406035637885;10079.798404032024;34399;35601.82199088988;35935.281294373446;36266.27467450583;36601.81699091488;46126.769366152956;47093;47343;47817.52182478131;48011.03977920492;11024.889751102386;11230.21388502797;11504;12263.570775022832;12340.568080117153;13400.865991339962;13557.79663305071;13684.110532815335;13948.79076813869;14009.08940918837;12263.325517096646;12437.564685235973;12471.127021108798;12936.288504131986;12994.09041367133;12268.631941041784;12343.259404435763;12557.623271301876;12664.823373227156;12797.616071517868;12583.559575414816;12587.370631468573;12673.429695663533;12718.491260349852;12748.553800616934;10363.533640986023;10447.634332798316;10690.41202733826;10731.731706707395;10781.568737250422;10545.472726363805;10756.085732712807;10892.945535272273;10919.344839309666;10924.453777310944 09:34:04 INFO - PROCESS | 3388 | __end_tp_report 09:34:04 INFO - PROCESS | 3388 | __start_cc_report 09:34:04 INFO - PROCESS | 3388 | _x_x_mozilla_cycle_collect,747 09:34:04 INFO - PROCESS | 3388 | __end_cc_report 09:34:04 INFO - PROCESS | 3388 | __startTimestamp1453829644360__endTimestamp 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | ------- Summary: start ------- 09:34:04 INFO - PROCESS | 3388 | Number of tests: 6 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#0] dojo.html Cycles:165 Average:5266.09 Median:5424.05 stddev:561.29 (10.3%) stddev-sans-first:540.52 09:34:04 INFO - PROCESS | 3388 | Values: 3260.9 3300.6 3307.5 3337.1 3364.2 5305.7 5312.6 5314.1 5315.3 5361.4 5297.9 5318.3 5331.1 5341.9 5343.3 4683.0 4721.6 4853.5 4864.4 4885.2 4740.8 4799.5 4806.9 4807.2 4809.2 4764.0 4811.5 4817.1 4841.0 4917.7 4909.5 4937.0 4937.2 4938.2 4968.8 4826.8 4866.0 4868.7 4898.8 4907.4 4998.3 5054.3 5128.6 5185.8 5217.6 5633.0 5655.7 5686.0 5686.6 5687.0 5507.0 5700.3 5727.5 5728.6 5731.7 5286.9 5321.7 5378.4 5382.8 5383.9 5851.3 5851.6 5854.3 5855.9 5858.2 5415.8 5437.0 5651.6 5681.4 5684.6 5686.1 5709.6 5737.4 5747.7 5785.4 5620.0 5635.1 5647.9 5652.4 5686.3 5487.8 5595.1 5597.5 5673.7 5688.8 4325.0 4336.8 4338.7 4339.2 4342.7 3867.0 3907.3 3916.5 3921.8 3968.3 5246.4 5267.5 5268.6 5269.5 5282.1 5639.2 5643.1 5643.9 5653.3 5688.7 5193.9 5233.6 5280.4 5334.0 5424.1 4925.9 4951.4 4955.1 4962.6 4995.1 5838.2 5850.8 5862.9 5868.3 5871.7 5376.5 5528.2 5646.3 5711.0 5748.0 5859.8 5872.9 5878.3 5883.9 5886.7 5481.0 5658.7 5669.5 5679.1 5681.6 5559.9 5568.7 5587.7 5614.4 5621.2 5494.5 5495.4 5496.0 5499.5 5499.8 5498.9 5541.7 5552.2 5559.2 5586.5 5359.7 5467.4 5509.0 5514.6 5558.0 5462.1 5486.0 5491.2 5500.9 5543.6 5252.2 5319.4 5345.5 5371.3 5406.5 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#1] ext.html Cycles:180 Average:49250.41 Median:363220.00 stddev:86995.30 (24.0%) stddev-sans-first:87162.46 09:34:04 INFO - PROCESS | 3388 | Values: 537.6 540.7 555.8 565.4 581.0 28785.3 29507.4 29513.4 29523.3 29553.1 38061.0 38373.4 38513.2 38629.8 38636.8 8641.7 8839.3 8840.2 8848.4 8849.7 8566.9 8719.0 8722.6 8727.1 8736.9 8701.7 8814.9 8815.9 8980.7 9001.3 8847.5 8951.3 8974.2 8974.6 8982.2 8724.7 8819.6 8875.6 8882.0 8884.0 40871.4 41177.4 41354.6 41429.2 41458.6 3828.6 3885.5 3912.0 4030.3 4501.7 32242.8 32399.4 32417.4 32539.8 32772.7 3944.9 3959.9 4012.5 4027.7 4105.9 285402.0 286637.0 287213.0 287735.0 288074.0 42470.2 42600.1 54559.0 55234.2 62093.7 61661.7 61862.7 62150.1 62171.4 62176.7 17474.1 17594.6 17635.9 17651.6 17657.9 12023.2 12199.9 13359.7 13778.4 13784.3 10878.2 12470.6 20697.7 20818.2 20850.4 7333.3 7645.0 7666.0 7784.5 7802.8 1090.4 1109.6 1195.1 1203.8 1211.8 30810.7 30823.8 30883.0 31259.5 31841.0 1104.9 1137.9 1150.9 1251.6 1268.1 13547.7 14297.4 14696.3 15921.5 16643.9 357520.0 360857.0 361647.0 364793.0 369087.0 53822.0 54176.5 54195.7 54216.7 54292.5 1480.9 1488.5 1490.9 1502.6 1502.8 30665.2 30673.0 30874.7 31120.5 31421.4 47158.3 47411.1 47421.3 47439.0 47489.1 337529.0 340554.0 341048.0 341095.0 341132.0 27629.4 31931.5 32733.7 33172.3 33220.2 39449.4 40002.0 40428.2 40863.8 41314.6 33743.8 33761.0 33805.2 34126.0 34167.1 30973.4 34165.1 35544.3 36847.0 37046.1 39046.2 39175.6 39528.2 39789.2 40023.0 30802.0 31382.5 32033.4 32056.5 32190.2 24970.6 25087.9 25166.5 25206.7 25518.7 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#2] jquery.html Cycles:180 Average:28874.19 Median:2133.82 stddev:93032.93 (4359.9%) stddev-sans-first:93269.31 09:34:04 INFO - PROCESS | 3388 | Values: 385.9 388.3 389.2 393.3 409.4 13689.5 15848.2 16423.9 19307.8 19352.0 16442.2 16810.6 16914.6 18211.2 18757.3 5022.4 5215.3 5230.6 5235.2 5238.3 3879.4 4029.8 5158.9 5394.8 5597.2 5532.9 5569.1 5598.7 5600.0 5706.4 5495.3 5841.8 5845.9 5852.8 5883.7 5372.1 5374.9 5378.2 5380.8 5382.0 13033.9 13122.8 13745.4 13899.3 13905.1 1985.2 2162.3 2239.9 2246.2 2378.4 10354.8 11628.4 12676.7 13177.8 13858.1 1860.3 2002.2 2006.1 2017.4 2028.7 58693.4 59343.7 60770.0 61157.4 62763.7 10620.4 10927.8 10967.8 10971.3 11114.7 14006.2 14751.0 14829.6 14863.0 14865.9 8041.6 8274.4 8415.3 8444.5 8449.7 8194.4 8271.6 8292.1 8342.3 8363.5 4417.4 4834.0 4834.7 4907.6 4937.7 1835.7 1907.7 1936.2 1966.5 2008.1 955.4 1037.7 1040.4 1115.1 1157.1 12918.5 16545.7 16920.6 17189.1 17223.0 1028.7 1035.5 1050.4 1069.1 1095.2 9327.3 9699.2 9735.0 9897.2 10221.3 559565.0 562208.0 562966.0 576026.0 584510.0 77339.0 77470.6 77857.6 79073.6 79641.0 1257.1 1257.1 1257.2 1261.5 1274.2 15489.8 15530.9 15623.5 15876.0 16068.0 34048.5 34660.3 34969.8 35017.6 35814.8 44919.0 44967.6 45449.5 45918.3 48457.8 4464.8 5380.5 7172.2 7263.7 7530.9 9669.9 11469.0 11673.1 11817.1 11879.2 9691.5 9959.0 9977.7 10362.6 10437.5 9638.5 9666.2 9667.7 9857.0 9911.8 8355.3 10199.6 10276.2 10409.3 10627.5 7195.9 7497.0 7523.7 7590.0 7611.6 9952.3 10102.8 10226.8 10398.8 10671.6 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#3] mootools.html Cycles:180 Average:5709.73 Median:6749.85 stddev:2915.91 (43.2%) stddev-sans-first:2906.29 09:34:04 INFO - PROCESS | 3388 | Values: 1423.9 1552.4 1574.3 1800.4 1926.1 7139.2 7315.7 7734.3 7883.4 7899.2 7992.7 8007.4 8043.4 8060.6 8082.4 2036.4 2080.5 2353.7 2386.9 2387.7 2340.6 2415.4 2422.7 2423.8 2425.1 2373.3 2398.0 2416.8 2416.9 2418.4 2371.8 2383.6 2398.5 2400.4 2405.4 2428.7 2432.4 2450.9 2450.9 2451.2 8102.9 8260.3 8264.4 8268.2 8270.2 4806.0 4926.0 4966.3 4967.8 4975.6 3241.4 3255.5 3256.6 3273.0 3337.9 1075.1 1080.4 1094.9 1105.1 1105.3 10849.3 11037.2 11106.2 11109.1 11112.2 4382.7 4417.1 4431.1 4497.0 4512.3 9543.1 9552.9 9571.3 9577.0 9639.1 4860.1 4908.8 4923.6 4956.4 4960.8 4491.0 4535.9 4542.3 4556.3 4556.3 3520.3 3580.3 3758.9 3820.2 3913.1 1207.9 1258.3 1274.2 1275.5 1275.5 1197.9 1209.4 1217.1 1454.8 1476.7 7687.0 7792.6 7794.3 7798.4 7815.0 1187.0 1187.6 1192.5 1192.8 1210.3 5942.4 6064.7 6081.9 6087.4 6090.5 8995.1 9126.7 9304.1 9433.7 9440.2 9350.4 9355.9 9357.4 9372.3 9378.1 7379.7 7637.1 7706.0 7723.3 7750.4 7365.9 7708.7 7747.2 7802.9 7809.6 8738.5 8753.7 8858.8 8908.2 9062.0 9130.7 9155.7 9343.2 9378.1 9391.7 7510.2 7570.3 7655.6 7697.3 7706.2 7045.0 7231.5 7627.9 7766.0 7817.6 7201.8 7353.9 7354.3 7388.2 7438.8 7205.9 7213.5 7302.0 7317.2 7325.0 7187.8 7335.0 7367.0 7506.0 7515.5 6732.7 6767.0 6776.4 6807.2 6813.3 6929.8 6995.7 6996.8 7042.8 7054.1 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#4] prototype.html Cycles:180 Average:5394.53 Median:6087.33 stddev:1599.01 (26.3%) stddev-sans-first:1558.15 09:34:04 INFO - PROCESS | 3388 | Values: 356.9 362.0 364.5 365.9 366.6 5869.4 6007.3 6040.4 6043.2 6077.2 5825.9 6016.0 6020.1 6066.7 6077.4 4625.8 4635.9 4638.5 4640.7 4646.7 4464.0 4532.4 4543.6 4558.0 4634.2 4509.3 4567.2 4664.7 4665.0 4680.3 4620.7 4641.8 4645.7 4649.9 4667.0 4137.5 4142.5 4142.9 4155.5 4160.2 5675.7 5683.8 5731.9 5750.7 5750.8 5456.5 5462.9 5466.2 5471.7 5474.7 6003.5 6338.9 6347.3 6350.6 6352.1 4464.6 4466.4 4597.9 4606.3 4616.7 6625.2 6646.4 6649.5 6658.7 6663.2 4716.6 4731.3 4731.8 4732.6 4734.6 4710.3 4789.5 4791.5 4792.6 4804.9 5431.6 5437.2 5438.7 5448.1 5453.6 6416.7 6421.5 6422.5 6423.9 6425.1 1665.0 1677.2 1677.4 1679.3 1681.3 1105.6 1114.4 1116.0 1131.9 1168.7 6097.3 6149.4 6157.4 6160.4 6162.4 6413.6 6510.9 6516.9 6593.0 6604.9 6134.2 6145.4 6145.5 6151.7 6153.4 3526.3 3560.4 3564.5 3566.4 3566.8 6701.3 6738.4 6759.7 6891.2 6903.6 6874.1 6892.7 6893.6 6897.1 6899.9 6879.7 6884.1 6885.4 6890.8 6894.7 6355.2 6460.1 6465.5 6476.5 6714.0 6452.7 6525.2 6550.9 6568.7 6569.1 6819.6 6819.9 6823.7 6830.7 6832.1 4617.9 4710.5 4776.0 4795.7 4815.6 6631.8 6639.4 6640.4 6642.5 6647.3 6429.3 6439.6 6440.1 6441.3 6441.9 6315.7 6362.9 6460.4 6520.4 6522.4 6434.7 6481.7 6481.9 6482.4 6486.8 6504.2 6539.1 6540.7 6542.7 6549.7 6134.8 6369.0 6373.5 6379.2 6379.9 09:34:04 INFO - PROCESS | 3388 | 09:34:04 INFO - PROCESS | 3388 | [#5] yui.html Cycles:180 Average:14693.33 Median:24433.30 stddev:16511.11 (67.6%) stddev-sans-first:16524.73 09:34:04 INFO - PROCESS | 3388 | Values: 855.4 856.8 892.2 914.0 957.1 14377.2 14601.3 14604.1 14620.2 14628.1 13690.6 13731.4 13757.8 13763.9 13779.9 884.2 904.8 907.5 913.9 916.7 892.4 903.2 903.5 904.3 905.4 944.8 952.1 953.2 953.4 960.7 942.5 950.1 951.6 952.3 953.3 702.9 705.7 706.0 706.8 707.2 15180.2 15216.8 15230.5 15252.5 15296.8 13784.6 13938.9 13939.2 14027.2 14055.9 11682.9 11712.5 11903.8 12155.2 12344.9 3876.7 3927.0 3940.3 3950.1 4035.4 45888.8 46158.1 47632.5 51791.0 54522.7 11066.5 11390.9 11474.5 11482.7 11581.9 16538.3 19026.0 19047.6 19069.6 19080.9 6969.5 7246.9 7966.3 8052.8 8103.5 4793.3 4835.4 4855.4 4889.9 4947.7 3290.9 3321.9 3323.5 3328.4 3329.0 606.8 613.2 615.2 622.1 631.0 586.3 653.0 732.3 751.4 757.0 9598.5 10111.6 10146.5 10260.2 10471.7 695.7 699.8 722.0 738.8 757.0 4092.5 4514.2 4522.5 4534.5 4540.4 60383.0 61645.7 61665.7 61692.0 61711.7 46387.0 54001.2 54074.0 54250.0 55028.0 44774.1 46142.3 47141.8 48163.5 48603.8 9627.8 9839.9 9889.9 9899.4 10079.8 34399.0 35601.8 35935.3 36266.3 36601.8 46126.8 47093.0 47343.0 47817.5 48011.0 11024.9 11230.2 11504.0 12263.6 12340.6 13400.9 13557.8 13684.1 13948.8 14009.1 12263.3 12437.6 12471.1 12936.3 12994.1 12268.6 12343.3 12557.6 12664.8 12797.6 12583.6 12587.4 12673.4 12718.5 12748.6 10363.5 10447.6 10690.4 10731.7 10781.6 10545.5 10756.1 10892.9 10919.3 10924.5 09:34:04 INFO - PROCESS | 3388 | -------- Summary: end -------- 09:34:04 INFO - PROCESS | 3388 | 09:34:05 INFO - TEST-INFO | 3388: exit 0 09:34:05 INFO - TEST-OK | dromaeo_css | took 1112818ms 09:34:05 INFO - TEST-START | kraken 09:34:05 INFO - operating with platform_type : linux_ 09:34:05 INFO - Initialising browser for kraken test... 09:34:05 INFO - TEST-INFO | started process 3596 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpthdqD5/profile http://localhost:35497/getInfo.html) 09:34:08 INFO - PROCESS | 3596 | __metrics Screen width/height:1600/1200 09:34:08 INFO - PROCESS | 3596 | colorDepth:24 09:34:08 INFO - PROCESS | 3596 | Browser inner width/height: 1024/697 09:34:08 INFO - PROCESS | 3596 | __metrics 09:34:08 INFO - PROCESS | 3596 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:09 INFO - TEST-INFO | 3596: exit 0 09:34:09 INFO - Browser initialized. 09:34:09 INFO - Running cycle 1/1 for kraken test... 09:34:09 INFO - TEST-INFO | started process 3689 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpthdqD5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:21 INFO - PROCESS | 3689 | RSS: Main: 136118272 09:34:21 INFO - PROCESS | 3689 | 09:34:23 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-beat-detection) 09:34:24 INFO - PROCESS | 3689 | RSS: Main: 175419392 09:34:24 INFO - PROCESS | 3689 | 09:34:27 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-dft) 09:34:27 INFO - PROCESS | 3689 | RSS: Main: 169000960 09:34:27 INFO - PROCESS | 3689 | 09:34:30 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-fft) 09:34:31 INFO - PROCESS | 3689 | RSS: Main: 167743488 09:34:31 INFO - PROCESS | 3689 | 09:34:33 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35497/tests/kraken/driver.html?testName=audio-oscillator) 09:34:33 INFO - PROCESS | 3689 | RSS: Main: 168972288 09:34:33 INFO - PROCESS | 3689 | 09:34:35 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:34:36 INFO - PROCESS | 3689 | RSS: Main: 165322752 09:34:36 INFO - PROCESS | 3689 | 09:34:39 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-darkroom) 09:34:39 INFO - PROCESS | 3689 | RSS: Main: 164433920 09:34:39 INFO - PROCESS | 3689 | 09:34:43 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35497/tests/kraken/driver.html?testName=imaging-desaturate) 09:34:43 INFO - PROCESS | 3689 | RSS: Main: 164290560 09:34:43 INFO - PROCESS | 3689 | 09:34:46 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35497/tests/kraken/driver.html?testName=json-parse-financial) 09:34:47 INFO - PROCESS | 3689 | RSS: Main: 164798464 09:34:47 INFO - PROCESS | 3689 | 09:34:48 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:34:49 INFO - PROCESS | 3689 | RSS: Main: 172474368 09:34:49 INFO - PROCESS | 3689 | 09:34:50 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:34:51 INFO - PROCESS | 3689 | RSS: Main: 170471424 09:34:51 INFO - PROCESS | 3689 | 09:34:53 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:54 INFO - PROCESS | 3689 | RSS: Main: 174374912 09:34:54 INFO - PROCESS | 3689 | 09:34:56 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:57 INFO - PROCESS | 3689 | RSS: Main: 177692672 09:34:57 INFO - PROCESS | 3689 | 09:34:59 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:00 INFO - PROCESS | 3689 | RSS: Main: 177897472 09:35:00 INFO - PROCESS | 3689 | 09:35:01 INFO - PROCESS | 3689 | Cycle 1(1): loaded http://localhost:35497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35497/tests/kraken/driver.html?testName=ai-astar) 09:35:02 INFO - PROCESS | 3689 | RSS: Main: 236744704 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | __start_tp_report 09:35:02 INFO - PROCESS | 3689 | _x_x_mozilla_page_load 09:35:02 INFO - PROCESS | 3689 | _x_x_mozilla_page_load_details 09:35:02 INFO - PROCESS | 3689 | |i|pagename|runs| 09:35:02 INFO - PROCESS | 3689 | |0;ai-astar;110;112;105;110;109;110;110;110;99;109 09:35:02 INFO - PROCESS | 3689 | |1;audio-beat-detection;157;122;149;159;128;156;152;125;164;123 09:35:02 INFO - PROCESS | 3689 | |2;audio-dft;159;160;160;162;161;162;160;161;159;159 09:35:02 INFO - PROCESS | 3689 | |3;audio-fft;73;75;74;141;73;73;76;76;142;74 09:35:02 INFO - PROCESS | 3689 | |4;audio-oscillator;95;96;143;95;96;95;144;94;95;137 09:35:02 INFO - PROCESS | 3689 | |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;108;109 09:35:02 INFO - PROCESS | 3689 | |6;imaging-darkroom;145;146;146;145;147;146;146;146;146;146 09:35:02 INFO - PROCESS | 3689 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;96;96 09:35:02 INFO - PROCESS | 3689 | |8;json-parse-financial;54;58;55;55;59;57;56;57;62;55 09:35:02 INFO - PROCESS | 3689 | |9;json-stringify-tinderbox;65;66;65;66;65;65;65;65;66;66 09:35:02 INFO - PROCESS | 3689 | |10;stanford-crypto-aes;82;82;82;90;81;83;82;82;82;84 09:35:02 INFO - PROCESS | 3689 | |11;stanford-crypto-ccm;113;111;113;117;126;113;121;112;112;110 09:35:02 INFO - PROCESS | 3689 | |12;stanford-crypto-pbkdf2;139;138;140;138;138;138;146;139;134;137 09:35:02 INFO - PROCESS | 3689 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;64;66;70;66;64 09:35:02 INFO - PROCESS | 3689 | __end_tp_report 09:35:02 INFO - PROCESS | 3689 | __start_cc_report 09:35:02 INFO - PROCESS | 3689 | _x_x_mozilla_cycle_collect,901 09:35:02 INFO - PROCESS | 3689 | __end_cc_report 09:35:02 INFO - PROCESS | 3689 | __startTimestamp1453829702174__endTimestamp 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | ------- Summary: start ------- 09:35:02 INFO - PROCESS | 3689 | Number of tests: 14 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.93 09:35:02 INFO - PROCESS | 3689 | Values: 110.0 112.0 105.0 110.0 109.0 110.0 110.0 110.0 99.0 109.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:154.00 stddev:16.89 (11.0%) stddev-sans-first:17.19 09:35:02 INFO - PROCESS | 3689 | Values: 157.0 122.0 149.0 159.0 128.0 156.0 152.0 125.0 164.0 123.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.16 (0.7%) stddev-sans-first:1.13 09:35:02 INFO - PROCESS | 3689 | Values: 159.0 160.0 160.0 162.0 161.0 162.0 160.0 161.0 159.0 159.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.00 stddev:28.38 (38.3%) stddev-sans-first:29.60 09:35:02 INFO - PROCESS | 3689 | Values: 73.0 75.0 74.0 141.0 73.0 73.0 76.0 76.0 142.0 74.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.39 (23.6%) stddev-sans-first:23.17 09:35:02 INFO - PROCESS | 3689 | Values: 95.0 96.0 143.0 95.0 96.0 95.0 144.0 94.0 95.0 137.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:35:02 INFO - PROCESS | 3689 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 108.0 109.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 09:35:02 INFO - PROCESS | 3689 | Values: 145.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:35:02 INFO - PROCESS | 3689 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:2.39 (4.2%) stddev-sans-first:2.32 09:35:02 INFO - PROCESS | 3689 | Values: 54.0 58.0 55.0 55.0 59.0 57.0 56.0 57.0 62.0 55.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:35:02 INFO - PROCESS | 3689 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.00 stddev:2.58 (3.1%) stddev-sans-first:2.71 09:35:02 INFO - PROCESS | 3689 | Values: 82.0 82.0 82.0 90.0 81.0 83.0 82.0 82.0 82.0 84.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:113.00 stddev:5.07 (4.5%) stddev-sans-first:5.34 09:35:02 INFO - PROCESS | 3689 | Values: 113.0 111.0 113.0 117.0 126.0 113.0 121.0 112.0 112.0 110.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:138.50 stddev:3.02 (2.2%) stddev-sans-first:3.20 09:35:02 INFO - PROCESS | 3689 | Values: 139.0 138.0 140.0 138.0 138.0 138.0 146.0 139.0 134.0 137.0 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - PROCESS | 3689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.71 (2.6%) stddev-sans-first:1.81 09:35:02 INFO - PROCESS | 3689 | Values: 66.0 67.0 67.0 67.0 67.0 64.0 66.0 70.0 66.0 64.0 09:35:02 INFO - PROCESS | 3689 | -------- Summary: end -------- 09:35:02 INFO - PROCESS | 3689 | 09:35:02 INFO - TEST-INFO | 3689: exit 0 09:35:02 INFO - TEST-OK | kraken | took 57929ms 09:35:02 INFO - TEST-START | v8_7 09:35:02 INFO - operating with platform_type : linux_ 09:35:02 INFO - Initialising browser for v8_7 test... 09:35:03 INFO - TEST-INFO | started process 3944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkFVO8x/profile http://localhost:35497/getInfo.html) 09:35:06 INFO - PROCESS | 3944 | __metrics Screen width/height:1600/1200 09:35:06 INFO - PROCESS | 3944 | colorDepth:24 09:35:06 INFO - PROCESS | 3944 | Browser inner width/height: 1024/697 09:35:06 INFO - PROCESS | 3944 | __metrics 09:35:06 INFO - PROCESS | 3944 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:07 INFO - TEST-INFO | 3944: exit 0 09:35:07 INFO - Browser initialized. 09:35:07 INFO - Running cycle 1/1 for v8_7 test... 09:35:07 INFO - TEST-INFO | started process 4032 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkFVO8x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:19 INFO - PROCESS | 4032 | RSS: Main: 136323072 09:35:19 INFO - PROCESS | 4032 | 09:35:41 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:35497/tests/v8_7/run.html (next: http://localhost:35497/tests/v8_7/run.html) 09:35:42 INFO - PROCESS | 4032 | RSS: Main: 423555072 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | __start_tp_report 09:35:42 INFO - PROCESS | 4032 | _x_x_mozilla_page_load 09:35:42 INFO - PROCESS | 4032 | _x_x_mozilla_page_load_details 09:35:42 INFO - PROCESS | 4032 | |i|pagename|runs| 09:35:42 INFO - PROCESS | 4032 | |0;Richards;165.8649859014762 09:35:42 INFO - PROCESS | 4032 | |1;DeltaBlue;171.7032967032967 09:35:42 INFO - PROCESS | 4032 | |2;Encrypt;279.09572983533354 09:35:42 INFO - PROCESS | 4032 | |3;Decrypt;5208.333333333333 09:35:42 INFO - PROCESS | 4032 | |4;RayTrace;962.4639076034649 09:35:42 INFO - PROCESS | 4032 | |5;Earley;574.3825387708214 09:35:42 INFO - PROCESS | 4032 | |6;Boyer;11155.555555555555 09:35:42 INFO - PROCESS | 4032 | |7;RegExp;40380 09:35:42 INFO - PROCESS | 4032 | |8;Splay;501.5045135406219 09:35:42 INFO - PROCESS | 4032 | |9;NavierStokes;4822.115384615385 09:35:42 INFO - PROCESS | 4032 | __end_tp_report 09:35:42 INFO - PROCESS | 4032 | __startTimestamp1453829742152__endTimestamp 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | ------- Summary: start ------- 09:35:42 INFO - PROCESS | 4032 | Number of tests: 10 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 165.9 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#1] DeltaBlue Cycles:1 Average:171.70 Median:171.70 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 171.7 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 279.1 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 5208.3 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 962.5 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#5] Earley Cycles:1 Average:574.38 Median:574.38 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 574.4 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#6] Boyer Cycles:1 Average:11155.56 Median:11155.56 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 11155.6 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#7] RegExp Cycles:1 Average:40380.00 Median:40380.00 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 40380.0 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#8] Splay Cycles:1 Average:501.50 Median:501.50 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 501.5 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - PROCESS | 4032 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:35:42 INFO - PROCESS | 4032 | Values: 4822.1 09:35:42 INFO - PROCESS | 4032 | -------- Summary: end -------- 09:35:42 INFO - PROCESS | 4032 | 09:35:42 INFO - TEST-INFO | 4032: exit 0 09:35:43 INFO - TEST-OK | v8_7 | took 40018ms 09:35:43 INFO - SUITE-END | took 1210s 09:35:43 INFO - Completed test suite (00:20:10) 09:35:43 INFO - Working with test: dromaeo_css 09:35:43 INFO - Generating results file: dromaeo_css 09:35:43 INFO - Working with test: kraken 09:35:43 INFO - Generating results file: kraken 09:35:43 INFO - javascript benchmark 09:35:43 INFO - Working with test: v8_7 09:35:43 INFO - Generating results file: v8_7 09:35:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:35:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 09:35:43 INFO - process_Request line: dromaeo_css 7153.63 graph.html#tests=[[72,52,35]] 09:35:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:35:43 INFO - process_Request line: kraken 1485.10 graph.html#tests=[[232,52,35]] 09:35:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:35:43 INFO - process_Request line: v8_7 21897.10 graph.html#tests=[[230,52,35]] 09:35:43 INFO - RETURN: dromaeo_css: 7153.63 09:35:43 INFO - RETURN: kraken: 1485.10 09:35:43 INFO - RETURN: v8_7: 21897.10 09:35:43 INFO - javascript benchmark 09:35:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3260.869565217391, 3300.636929937708, 3307.4542700454413, 3337.098983274516, 3364.2262279675665, 5305.681659100456, 5312.60155488338, 5314.149736042229, 5315.309009828722, 5361.410244873061, 5297.920531192035, 5318.282031925689, 5331.120365139757, 5341.893162136765, 5343.278657381253, 4682.953170468286, 4721.551452611996, 4853.514648535153, 4864.440589332228, 4885.2427873679635, 4740.810367585293, 4799.472058073609, 4806.927896081562, 4807.206810876201, 4809.158397280479, 4764.0471905619015, 4811.494793046732, 4817.060673168733, 4841.0, 4917.72952487613, 4909.484504127069, 4937.037277730844, 4937.164716606136, 4938.209886418192, 4968.776405061781, 4826.831060912851, 4866.02679464105, 4868.659193856432, 4898.755062246909, 4907.411110666707, 4998.325226094504, 5054.267131265946, 5128.589712822965, 5185.792568297264, 5217.5565076968505, 5632.971835140839, 5655.745491452894, 5686.0333743263745, 5686.601937864351, 5687.0, 5506.972465137689, 5700.2589663343915, 5727.455891690282, 5728.598998070137, 5731.684757338345, 5286.867828304285, 5321.6540924839765, 5378.408375078739, 5382.838514844561, 5383.892322153574, 5851.32709738377, 5851.561132914963, 5854.268216472941, 5855.912161317584, 5858.150568167592, 5415.83752487426, 5437.0, 5651.6043876928225, 5681.375048744635, 5684.573656975744, 5686.118651609007, 5709.600327977002, 5737.3975732548315, 5747.655140691572, 5785.421457854265, 5620.016497112989, 5635.126555383922, 5647.887042259132, 5652.378238393773, 5686.317641883001, 5487.835364939058, 5595.132754423071, 5597.496225339739, 5673.74468148926, 5688.800891968761, 4324.956750432519, 4336.82652693895, 4338.652907767434, 4339.175556644227, 4342.652587792969, 3866.980665096713, 3907.27715372657, 3916.4516967624554, 3921.784301863368, 3968.3452230381663, 5246.42289348179, 5267.499587539178, 5268.604854635841, 5269.473052694777, 5282.075636763551, 5639.238702775155, 5643.125315576092, 5643.887122257532, 5653.349864765604, 5688.715564221855, 5193.948060519422, 5233.607479439057, 5280.419153893069, 5334.0, 5424.05079111154, 4925.87685307863, 4951.430585482643, 4955.083309587738, 4962.60299176065, 4995.100881841231, 5838.211841401441, 5850.795222167204, 5862.853428664317, 5868.325142608569, 5871.735771890275, 5376.516113549799, 5528.170774383714, 5646.322441307069, 5710.971445142748, 5747.971260143672, 5859.824205273678, 5872.882542349043, 5878.29460464747, 5883.882322353444, 5886.676232807065, 5480.972595136999, 5658.688772117408, 5669.489745922887, 5679.148127780701, 5681.630694004876, 5559.916601251065, 5568.6658800472105, 5587.720613969204, 5614.354349249726, 5621.184928185472, 5494.450554944474, 5495.422980587141, 5496.038193316233, 5499.50504454601, 5499.752511137089, 5498.890022199614, 5541.667499950016, 5552.222688823649, 5559.2217089606675, 5586.52514536269, 5359.678419294854, 5467.39858615544, 5508.9724551376985, 5514.641548299348, 5557.972210138923, 5462.126059830408, 5485.985092757853, 5491.231227628055, 5500.87232117423, 5543.556515478833, 5252.1596544552685, 5319.38827034896, 5345.492178243217, 5371.274877891591, 5406.513413792777], "unit": "score", "name": "dojo.html", "value": 5231.767908643372}, {"lowerIsBetter": false, "replicates": [537.5538303208335, 540.6699519182815, 555.8304717061297, 565.4119715495885, 580.9977788315157, 28785.28036799081, 29507.40985180295, 29513.40973180535, 29523.261918452048, 29553.113406597837, 38061.0, 38373.42439863397, 38513.229735405344, 38629.8068509657, 38636.80681596595, 8641.697540586065, 8839.337049721264, 8840.160184782435, 8848.424852384574, 8849.690260840873, 8566.871496927552, 8718.956405217965, 8722.607482663296, 8727.127287271285, 8736.912630873705, 8701.651933922636, 8814.86777698335, 8815.911840881605, 8980.685676001342, 9001.324900632446, 8847.469151850877, 8951.283897288235, 8974.192322690924, 8974.641014359418, 8982.236509896667, 8724.738257852274, 8819.647214111428, 8875.600597973042, 8881.955590222007, 8883.978342490567, 40871.38692919609, 41177.382339264936, 41354.58645413537, 41429.1714165715, 41458.585414145775, 3828.559715632682, 3885.514310711161, 3911.9804400977814, 4030.294698427793, 4501.662375321864, 32242.838785806154, 32399.352012959607, 32417.351652967045, 32539.837300813346, 32772.6722732772, 3944.8816535503693, 3959.920801583952, 4012.498437695288, 4027.6979226558124, 4105.91788164235, 285402.0, 286637.0, 287213.0, 287734.9999999979, 288074.0, 42470.150596988504, 42600.14799703989, 54559.0, 55234.171487427724, 62093.68953155205, 61661.69169154126, 61862.69068654628, 62150.0677489838, 62171.37828621746, 62176.68911655413, 17474.126293685265, 17594.64810703779, 17635.911820441073, 17651.55871103233, 17657.911710441367, 12023.218490798245, 12199.93900030512, 13359.732805344032, 13778.448862045607, 13784.310784460737, 10878.238523303451, 12470.563530276397, 20697.68953465699, 20818.167273309202, 20850.374488765363, 7333.339999400079, 7645.025353908735, 7666.0, 7784.494007889469, 7802.765917022499, 1090.4275255490772, 1109.6338208391212, 1195.1394995603152, 1203.8374819399444, 1211.8121691137887, 30810.69189308078, 30823.845880770452, 30883.0, 31259.531107033414, 31841.0, 1104.872939611955, 1137.943102844871, 1150.8561429821273, 1251.5619533163501, 1268.105985280375, 13547.729045419233, 14297.428102875769, 14696.26518674062, 15921.522354329389, 16643.91678041602, 357520.0, 360857.0, 361647.0, 364793.0, 369087.0, 53822.0, 54176.45823541793, 54195.729021354644, 54216.72891635517, 54292.45707542953, 1480.8519148085106, 1488.5459934720013, 1490.8807295416125, 1502.646877983673, 1502.774583812437, 30665.233369165948, 30673.0, 30874.69125308718, 31120.53319200259, 31421.371572568878, 47158.29262560996, 47411.05177896492, 47421.288680669124, 47439.0, 47489.05021899612, 337529.0, 340554.0, 341048.0, 341095.0, 341132.0, 27629.447411051264, 31931.521027184146, 32733.672663274014, 33172.336553269284, 33220.1694957628, 39449.40825887671, 40002.0, 40428.1914361717, 40863.7956810214, 41314.58685413108, 33743.83128084344, 33761.0, 33805.15487112744, 34126.0, 34167.145821354665, 30973.380532388775, 34165.145871353416, 35544.28911421809, 36847.0, 37046.07384815401, 39046.219075618894, 39175.608243917195, 39528.209435810546, 39789.20421591494, 40023.0, 30802.0, 31382.529262061544, 32033.359332812746, 32056.51915221227, 32190.19524511906, 24970.62544061877, 25087.87456062708, 25166.49667006613, 25206.747932521175, 25518.74481255164], "unit": "score", "name": "ext.html", "value": 18906.470055464157}, {"lowerIsBetter": false, "replicates": [385.92474467478837, 388.2603640065676, 389.1846581411941, 393.34508044106565, 409.36957086087426, 13689.452421903137, 15848.20758962053, 16423.917880410598, 19307.806921930794, 19352.0, 16442.177891105457, 16810.579735506617, 16914.577135571588, 18211.180496877638, 18757.343492977747, 5022.422421421537, 5215.269862219292, 5230.555402790748, 5235.214717792323, 5238.345206849144, 3879.3792993121106, 4029.798510074499, 5158.871028224287, 5394.7842086316505, 5597.188407680884, 5532.861678458031, 5569.053260945649, 5598.720063996784, 5599.972000140014, 5706.400827913071, 5495.258140151069, 5841.824745257649, 5845.941540584582, 5852.795152169653, 5883.735231914553, 5372.086745253317, 5374.8925021499745, 5378.1663842104535, 5380.838574842761, 5382.0, 13033.86966130336, 13122.803157952638, 13745.38145783442, 13899.305034748222, 13905.096168749, 1985.2257619528395, 2162.3080614203304, 2239.921602743896, 2246.180144247338, 2378.3578433822945, 10354.792904141876, 11628.439909929617, 12676.68308292291, 13177.802332965013, 13858.099223550436, 1860.3209828412532, 2002.2491565662876, 2006.107282259395, 2017.404865564662, 2028.6652702304102, 58693.41306586922, 59343.703281483315, 60770.0, 61157.38842611561, 62763.6861815688, 10620.362778233331, 10927.781444371069, 10967.83548246777, 10971.298460063394, 11114.722131946604, 14006.229657368738, 14751.0, 14829.629259268604, 14863.0, 14865.851341486663, 8041.597920103972, 8274.420790544724, 8415.326773858076, 8444.493330400073, 8449.704260350858, 8194.385421093442, 8271.627776750061, 8292.12932642076, 8342.332613390914, 8363.540005299645, 4417.381566580617, 4833.984863178702, 4834.685745426536, 4907.60739140875, 4937.703737775745, 1835.6604028254815, 1907.7043058325983, 1936.206155476276, 1966.5182030402643, 2008.0562135796151, 955.4171955107379, 1037.7353774787382, 1040.375774535288, 1115.085629783586, 1157.0801213035656, 12918.547850825176, 16545.66908661844, 16920.57698557546, 17189.05460199676, 17223.0, 1028.717102796722, 1035.471909326234, 1050.406520316019, 1069.1393428290146, 1095.2497539185683, 9327.300452465957, 9699.175570076623, 9735.0, 9897.208223342115, 10221.284510084372, 559565.0, 562208.0, 562966.0, 576026.0, 584510.0, 77339.0, 77470.61264693753, 77857.61071194608, 79073.60463197762, 79641.0, 1257.0697683714168, 1257.1137348169518, 1257.226805514602, 1261.4954018392532, 1274.2409890822112, 15489.84510154884, 15530.9223453882, 15623.531294061197, 15876.0, 16068.0, 34048.48927266143, 34660.30679386348, 34969.82515087408, 35017.649823502456, 35814.820925896245, 44919.0, 44967.55032449633, 45449.545504544534, 45918.31122533098, 48457.75771121122, 4464.821407143678, 5380.493461830693, 7172.175199851875, 7263.745768898063, 7530.887036694345, 9669.854952175583, 11469.0, 11673.066154707432, 11817.113716471471, 11879.22785018971, 9691.515424228619, 9958.950205248928, 9977.650782222587, 10362.585496580052, 10437.478126093816, 9638.469884156159, 9666.178374838217, 9667.661631842851, 9856.950715246378, 9911.752206194902, 8355.289800367036, 10199.596411659917, 10276.17790576737, 10409.323393979366, 10627.521761520595, 7195.892061618975, 7497.0, 7523.699052037857, 7590.0, 7611.581363025087, 9952.25358098131, 10102.79264997637, 10226.846597300897, 10398.844017339594, 10671.626493072705], "unit": "score", "name": "jquery.html", "value": 8518.29095986121}, {"lowerIsBetter": false, "replicates": [1423.8504956979523, 1552.4411211963693, 1574.2915687940426, 1800.3698705453085, 1926.0851095729522, 7139.178994415637, 7315.707371705132, 7734.342580880618, 7883.36933045355, 7899.249571290733, 7992.720254791069, 8007.399445041616, 8043.436959412844, 8060.5566693831815, 8082.353411727063, 2036.389083275019, 2080.5214800595872, 2353.6587194856734, 2386.85678859269, 2387.6657267982496, 2340.625499920013, 2415.3961509622595, 2422.6608274841537, 2423.8303318767694, 2425.102711996564, 2373.2524254859663, 2398.0287983366766, 2416.794572461343, 2416.9274921752376, 2418.359134829263, 2371.750966148564, 2383.5709572276983, 2398.5083057973075, 2400.411899084727, 2405.3625789165885, 2428.672129262545, 2432.391902024494, 2450.889709963056, 2450.938726531851, 2451.240115564181, 8102.918970810276, 8260.339172866155, 8264.421490495668, 8268.214519620626, 8270.172982701743, 4805.951940480585, 4925.975370123162, 4966.255061740731, 4967.751612419364, 4975.577075948512, 3241.38413701396, 3255.4953982132806, 3256.5929258842643, 3272.967270327314, 3337.9499307510405, 1075.0808059109506, 1080.3733834376044, 1094.8521949536869, 1105.1269497097283, 1105.2760441910561, 10849.349039057683, 11037.227394082418, 11106.222564420494, 11109.111271098374, 11112.222144449972, 4382.693211475166, 4417.050334178167, 4431.135928493977, 4497.033137875373, 4512.2554778461845, 9543.093406126407, 9552.904470955202, 9571.28215383849, 9576.952115239379, 9639.132478077006, 4860.0765854488245, 4908.803647854117, 4923.606111511142, 4956.405231372259, 4960.801567937242, 4491.0, 4535.931961020588, 4542.341360502709, 4556.3393307970155, 4556.339330797082, 3520.2783429396914, 3580.3197392495345, 3758.9248215035545, 3820.1977584707524, 3913.1391093959282, 1207.8671346151916, 1258.2702032820941, 1274.2099898063261, 1275.483429211171, 1275.515304184404, 1197.8862008109215, 1209.3892584245075, 1217.056780994736, 1454.7672372420361, 1476.6677497562962, 7686.961565192139, 7792.649330780128, 7794.2985131338455, 7798.376129909594, 7815.0, 1187.0, 1187.6437068879475, 1192.5468322037743, 1192.8031874740743, 1210.2556927489532, 5942.37605051472, 6064.727087281083, 6081.908771368433, 6087.360827113178, 6090.543209259324, 8995.100489951083, 9126.726198214064, 9304.116108969638, 9433.716988490356, 9440.150386465251, 9350.438973661601, 9355.90644093564, 9357.438553686801, 9372.297077719199, 9378.109079637423, 7379.6679149438405, 7637.121731000895, 7705.961470192613, 7723.34351580122, 7750.379969602418, 7365.852682946418, 7708.691652334068, 7747.225277472207, 7802.921970780447, 7809.609519524115, 8738.475691458278, 8753.737387878375, 8858.822823543363, 8908.153725396078, 9062.0, 9130.726078217664, 9155.725328240163, 9343.159115679622, 9378.062193780841, 9391.718248452557, 7510.211427800221, 7570.280823321776, 7655.617219139132, 7697.268759467842, 7706.152323244327, 7045.048918395951, 7231.4937954342695, 7627.923720762943, 7765.961170194113, 7817.648205830637, 7201.819954501179, 7353.889691654523, 7354.301341372561, 7388.224236455095, 7438.814029649302, 7205.891911621225, 7213.495055346285, 7301.963490182515, 7317.231690672403, 7324.96337518309, 7187.820304492429, 7334.96332518334, 7367.042284502981, 7505.962470187614, 7515.473916825769, 6732.730690772511, 6766.966165169143, 6776.356246156607, 6807.183138023271, 6813.250542440427, 6929.757458488929, 6995.685194166173, 6996.825079372853, 7042.753503627348, 7054.08296921397], "unit": "score", "name": "mootools.html", "value": 4719.041823086991}, {"lowerIsBetter": false, "replicates": [356.9482425048368, 361.95113659655937, 364.46241793354807, 365.9469376940344, 366.5711117991949, 5869.3837147099475, 6007.339192688801, 6040.395960403968, 6043.18417013703, 6077.179580756602, 5825.8834823303505, 6015.9699201504045, 6020.066889632103, 6066.726997285122, 6077.3922607739205, 4625.838095666652, 4635.860924172263, 4638.536146385368, 4640.721556706591, 4646.72119672819, 4464.040231350259, 4532.410786597754, 4543.568361005699, 4558.0, 4634.189016922042, 4509.346144809001, 4567.223571992769, 4664.650151238654, 4665.020345727401, 4680.25115981443, 4620.745858977755, 4641.767911604423, 4645.651576131803, 4649.907001859978, 4667.043256132519, 4137.482814648169, 4142.5028996520305, 4142.937855932163, 4155.501339839208, 4160.188763191179, 5675.744591493351, 5683.772649094072, 5731.856703582402, 5750.7412166452195, 5750.82747517571, 5456.508914197741, 5462.918056229159, 5466.180072989044, 5471.699056551888, 5474.698891560963, 6003.549733769941, 6338.904916426257, 6347.301796802348, 6350.555461117724, 6352.078948552434, 4464.553544645542, 4466.397036400077, 4597.908041839178, 4606.262997920317, 4616.722996620214, 6625.204975402934, 6646.435053020499, 6649.468042556632, 6658.700358483831, 6663.167104111986, 4716.551927566876, 4731.2903064539905, 4731.834385796549, 4732.574068333866, 4734.597559207437, 4710.3405523226775, 4789.544993225638, 4791.520847915251, 4792.640551958617, 4804.903901921942, 5431.5926305526455, 5437.211604317352, 5438.6736795791585, 5448.101063324586, 5453.64551304164, 6416.679166041679, 6421.486281097595, 6422.518311126684, 6423.903641445382, 6425.132607098076, 1664.96670066598, 1677.2033284190156, 1677.387753469999, 1679.2779104984975, 1681.2686481380395, 1105.5798796457295, 1114.3536748685742, 1115.966521004371, 1131.8924702153283, 1168.7195073182374, 6097.268327800603, 6149.354317796657, 6157.415045570664, 6160.44555989963, 6162.414570615874, 6413.615183088937, 6510.869782604322, 6516.934830651728, 6593.0, 6604.900926486107, 6134.171886795226, 6145.446909778141, 6145.477634401037, 6151.661658608819, 6153.384661533811, 3526.3123690880034, 3560.359135355661, 3564.465330200439, 3566.4293713005795, 3566.7503274771034, 6701.29636388182, 6738.427233685192, 6759.695813688396, 6891.242733103027, 6903.6203008835, 6874.106366172366, 6892.724291028403, 6893.551919125241, 6897.103376561015, 6899.862002759916, 6879.724811007503, 6884.105066341343, 6885.449164066863, 6890.793276201722, 6894.655267236719, 6355.205599300088, 6460.063290822711, 6465.547411681137, 6476.481881449378, 6714.026466162477, 6452.677366131768, 6525.2169739631545, 6550.934490655223, 6568.7372505099265, 6569.113169722217, 6819.556728812611, 6819.89770153458, 6823.658817059028, 6830.692618832065, 6832.077669514552, 4617.907641847077, 4710.458297295855, 4775.95224047769, 4795.712257264575, 4815.6147508198555, 6631.767888123893, 6639.3692599203, 6640.402363787089, 6642.535022548568, 6647.302033286435, 6429.324920883427, 6439.645819479973, 6440.13058237132, 6441.291457939529, 6441.903371449338, 6315.652639104894, 6362.936370636419, 6460.386263305167, 6520.445762110274, 6522.412982831568, 6434.67826608677, 6481.740730370921, 6481.935180648133, 6482.448991835558, 6486.837829054311, 6504.219493660791, 6539.084528165966, 6540.705668245036, 6542.705578248895, 6549.672516374258, 6134.7852825152695, 6368.968155159195, 6373.490120790233, 6379.234491861006, 6379.87240255183], "unit": "score", "name": "prototype.html", "value": 4883.898144649141}, {"lowerIsBetter": false, "replicates": [855.3820260871715, 856.8414843253998, 892.2014796756898, 914.0219964637838, 957.0812020460357, 14377.209253491066, 14601.269936503159, 14604.050736702107, 14620.195889226088, 14628.122312661248, 13690.589282321545, 13731.382087806047, 13757.79363309551, 13763.862361376383, 13779.862201378008, 884.2351366068336, 904.7828521154909, 907.5462268865567, 913.8903331600218, 916.7295647783886, 892.4422236102436, 903.2142036428316, 903.4940433357341, 904.3262769236927, 905.3571963905634, 944.834653935562, 952.057463111518, 953.1659797677032, 953.3707752883098, 960.7021823234785, 942.4910548303908, 950.1021534649759, 951.5813042261417, 952.2619969523605, 953.3088510829663, 702.9051078104493, 705.6894966214849, 706.0221593093551, 706.8126946359218, 707.1937990690617, 15180.165090919994, 15216.847831521654, 15230.466933657379, 15252.542423727306, 15296.770548441782, 13784.586462406143, 13938.860611393859, 13939.16365018102, 14027.228502432363, 14055.859441405557, 11682.94158529202, 11712.53149874004, 11903.821442678367, 12155.209911355734, 12344.938275308656, 3876.6511014008593, 3926.960730392688, 3940.310445672025, 3950.071733142709, 4035.394690796404, 45888.77055614734, 46158.07683846338, 47632.52367476316, 51791.0, 54522.727386362814, 11066.502007409686, 11390.886091139148, 11474.48364823585, 11482.712932176595, 11581.88418115825, 16538.338466461446, 19026.0, 19047.61904761897, 19069.61860762777, 19080.904595476935, 6969.47728920333, 7246.927530724625, 7966.322862556632, 8052.798680032929, 8103.473274237156, 4793.281007848851, 4835.419749629997, 4855.441624213261, 4889.877753056202, 4947.6536642434685, 3290.930447604538, 3321.850516726753, 3323.5347051412823, 3328.4008878401637, 3328.9667103329143, 606.8300875754795, 613.2365205319317, 615.1603061820672, 622.1476577089417, 630.9747610095636, 586.2788769813154, 652.9813490954127, 732.3006528765017, 751.3538357012965, 756.9583672897934, 9598.472084035446, 10111.595536178618, 10146.543405546769, 10260.179185665129, 10471.738206544896, 695.6938946863364, 699.8355386484172, 721.9747957899795, 738.78205929251, 757.0423414380813, 4092.4884389451317, 4514.187446259639, 4522.547745225451, 4534.501204867462, 4540.432445944257, 60383.0, 61645.691771540856, 61665.691671542256, 61692.0, 61711.691441542505, 46387.0, 54001.189982150296, 54074.0, 54250.0, 55028.0, 44774.10451790946, 46142.30786538205, 47141.76429117901, 48163.5183648159, 48603.75698121558, 9627.807443850943, 9839.85240221383, 9889.901100988898, 9899.406035637885, 10079.798404032024, 34399.0, 35601.82199088988, 35935.281294373446, 36266.27467450583, 36601.81699091488, 46126.769366152956, 47093.0, 47343.0, 47817.52182478131, 48011.03977920492, 11024.889751102386, 11230.21388502797, 11504.0, 12263.570775022832, 12340.568080117153, 13400.865991339962, 13557.79663305071, 13684.110532815335, 13948.79076813869, 14009.08940918837, 12263.325517096646, 12437.564685235973, 12471.127021108798, 12936.288504131986, 12994.09041367133, 12268.631941041784, 12343.259404435763, 12557.623271301876, 12664.823373227156, 12797.616071517868, 12583.559575414816, 12587.370631468573, 12673.429695663533, 12718.491260349852, 12748.553800616934, 10363.533640986023, 10447.634332798316, 10690.41202733826, 10731.731706707395, 10781.568737250422, 10545.472726363805, 10756.085732712807, 10892.945535272273, 10919.344839309666, 10924.453777310944], "unit": "score", "name": "yui.html", "value": 6900.655863431265}], "name": "dromaeo_css", "value": 7153.629805848193}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 109.0, 110.0, 110.0, 110.0, 99.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 149.0, 159.0, 128.0, 156.0, 152.0, 125.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [159.0, 160.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0, 159.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 141.0, 73.0, 73.0, 76.0, 76.0, 142.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 143.0, 95.0, 96.0, 95.0, 144.0, 94.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 108.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 55.0, 55.0, 59.0, 57.0, 56.0, 57.0, 62.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 90.0, 81.0, 83.0, 82.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [113.0, 111.0, 113.0, 117.0, 126.0, 113.0, 121.0, 112.0, 112.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 140.0, 138.0, 138.0, 138.0, 146.0, 139.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 64.0, 66.0, 70.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1485.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [171.7032967032967], "unit": "score", "name": "DeltaBlue", "value": 385.071232}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [574.3825387708214], "unit": "score", "name": "Earley", "value": 1160.3120830000003}, {"lowerIsBetter": false, "replicates": [11155.555555555555], "unit": "score", "name": "Boyer", "value": 59.74269920318723}, {"lowerIsBetter": false, "replicates": [40380.0], "unit": "score", "name": "RegExp", "value": 22.560302129767216}, {"lowerIsBetter": false, "replicates": [501.5045135406219], "unit": "score", "name": "Splay", "value": 162.49305400000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21897.10093968195}]} 09:35:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21897.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1485.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7153.63"}}} 09:35:43 INFO - Return code: 0 09:35:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:35:43 INFO - # TBPL SUCCESS # 09:35:43 INFO - Running post-action listener: _resource_record_post_action 09:35:43 INFO - Running post-run listener: _resource_record_post_run 09:35:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8069120; Write bytes: 399724544; Read time: 1780; Write time: 387268 09:35:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8237056; Read time: 0; Write time: 492 09:35:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 6307840; Write bytes: 391487488; Read time: 1708; Write time: 386776 09:35:44 INFO - Running post-run listener: _upload_blobber_files 09:35:44 INFO - Blob upload gear active. 09:35:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:35:44 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:35:44 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:35:44 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:35:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:46 INFO - (blobuploader) - INFO - Done attempting. 09:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:46 INFO - (blobuploader) - INFO - Done attempting. 09:35:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:35:46 INFO - Return code: 0 09:35:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:35:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:35:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d4d28e814809314f9e92e0da9880f4fd0d725d35769e041eae08801eedbb2e1a6f32424532e06201395947ff7b89861a0bfb6441d99e307cd0fb5aeb94409a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9c0cb389d272f064c03df47476e9c4525d81a460a344e6455aad1898549ad19956bcefeedc7ce9254f648287416aff74f312e91024370f781ac70b83691357"} 09:35:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:35:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:35:46 INFO - Contents: 09:35:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90d4d28e814809314f9e92e0da9880f4fd0d725d35769e041eae08801eedbb2e1a6f32424532e06201395947ff7b89861a0bfb6441d99e307cd0fb5aeb94409a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9c0cb389d272f064c03df47476e9c4525d81a460a344e6455aad1898549ad19956bcefeedc7ce9254f648287416aff74f312e91024370f781ac70b83691357"} 09:35:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:35:46 INFO - Copying logs to upload dir... 09:35:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:35:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.944446 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-26 09:35:46.854737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:35:46.857816) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 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/90d4d28e814809314f9e92e0da9880f4fd0d725d35769e041eae08801eedbb2e1a6f32424532e06201395947ff7b89861a0bfb6441d99e307cd0fb5aeb94409a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9c0cb389d272f064c03df47476e9c4525d81a460a344e6455aad1898549ad19956bcefeedc7ce9254f648287416aff74f312e91024370f781ac70b83691357"} 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.011307 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/90d4d28e814809314f9e92e0da9880f4fd0d725d35769e041eae08801eedbb2e1a6f32424532e06201395947ff7b89861a0bfb6441d99e307cd0fb5aeb94409a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9c0cb389d272f064c03df47476e9c4525d81a460a344e6455aad1898549ad19956bcefeedc7ce9254f648287416aff74f312e91024370f781ac70b83691357"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-26 09:35:46.882163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:35:46.882475) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453828470.591060-120709615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 09:35:46.965217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:35:46.965528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 09:35:46.965811) ========= ========= Total master_lag: 0.22 =========