builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1451947169.11 results: success (0) buildid: 20160104121333 builduid: 06de634a43b5417c8c6707855fa32313 revision: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.106389) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.106882) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.107270) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006301 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.135622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.135926) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.151036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.151397) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.203937) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.204436) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.204971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.205673) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 14:39:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-04 14:39:29 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102411 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.325710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.326016) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.381796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.382278) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 --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 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 --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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 14:39:29,425 truncating revision to first 12 chars 2016-01-04 14:39:29,425 Setting DEBUG logging. 2016-01-04 14:39:29,425 attempt 1/10 2016-01-04 14:39:29,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/45faafefe2f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 14:39:29,675 unpacking tar archive at: mozilla-aurora-45faafefe2f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.944355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.944664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.952529) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.952817) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 14:39:29.953250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2016-01-04 14:39:29.953546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:30 INFO - MultiFileLogger online at 20160104 14:39:30 in /builds/slave/test-pgo 14:39:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:39:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:39:30 INFO - {'append_to_log': False, 14:39:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:39:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:39:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:39:30 INFO - 'branch': 'Mozilla-Aurora', 14:39:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:30 INFO - 'config_files': ('talos/linux_config.py',), 14:39:30 INFO - 'default_actions': ('clobber', 14:39:30 INFO - 'read-buildbot-config', 14:39:30 INFO - 'download-and-extract', 14:39:30 INFO - 'populate-webroot', 14:39:30 INFO - 'create-virtualenv', 14:39:30 INFO - 'install', 14:39:30 INFO - 'run-tests'), 14:39:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:30 INFO - 'download_minidump_stackwalk': True, 14:39:30 INFO - 'download_symbols': 'ondemand', 14:39:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:30 INFO - 'installer_path': 'installer.exe', 14:39:30 INFO - 'log_level': 'info', 14:39:30 INFO - 'log_name': 'talos', 14:39:30 INFO - 'log_to_console': True, 14:39:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:30 INFO - 'opt_config_files': (), 14:39:30 INFO - 'pip_index': False, 14:39:30 INFO - 'sps_profile': False, 14:39:30 INFO - 'sps_profile_interval': 0, 14:39:30 INFO - 'suite': 'dromaeojs-e10s', 14:39:30 INFO - 'system_bits': '32', 14:39:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:30 INFO - 'title': 'talos-linux64-ix-049', 14:39:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:30 INFO - 'use_talos_json': True, 14:39:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:39:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:30 INFO - 'work_dir': 'build'} 14:39:30 INFO - ##### 14:39:30 INFO - ##### Running clobber step. 14:39:30 INFO - ##### 14:39:30 INFO - Running pre-action listener: _resource_record_pre_action 14:39:30 INFO - Running main action method: clobber 14:39:30 INFO - rmtree: /builds/slave/test-pgo/build 14:39:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:39:30 INFO - Running post-action listener: _resource_record_post_action 14:39:30 INFO - ##### 14:39:30 INFO - ##### Running read-buildbot-config step. 14:39:30 INFO - ##### 14:39:30 INFO - Running pre-action listener: _resource_record_pre_action 14:39:30 INFO - Running main action method: read_buildbot_config 14:39:30 INFO - Using buildbot properties: 14:39:30 INFO - { 14:39:30 INFO - "properties": { 14:39:30 INFO - "buildnumber": 41, 14:39:30 INFO - "product": "firefox", 14:39:30 INFO - "script_repo_revision": "production", 14:39:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:39:30 INFO - "repository": "", 14:39:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:39:30 INFO - "buildid": "20160104121333", 14:39:30 INFO - "slavename": "talos-linux64-ix-049", 14:39:30 INFO - "pgo_build": "True", 14:39:30 INFO - "basedir": "/builds/slave/test-pgo", 14:39:30 INFO - "project": "", 14:39:30 INFO - "platform": "ubuntu64_hw", 14:39:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:39:30 INFO - "slavebuilddir": "test", 14:39:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:39:30 INFO - "branch": "mozilla-aurora", 14:39:30 INFO - "repo_path": "releases/mozilla-aurora", 14:39:30 INFO - "stage_platform": "linux64-pgo", 14:39:30 INFO - "builduid": "06de634a43b5417c8c6707855fa32313", 14:39:30 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 14:39:30 INFO - }, 14:39:30 INFO - "sourcestamp": { 14:39:30 INFO - "repository": "", 14:39:30 INFO - "hasPatch": false, 14:39:30 INFO - "project": "", 14:39:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 14:39:30 INFO - "changes": [ 14:39:30 INFO - { 14:39:30 INFO - "category": null, 14:39:30 INFO - "files": [ 14:39:30 INFO - { 14:39:30 INFO - "url": null, 14:39:30 INFO - "name": "https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 14:39:30 INFO - } 14:39:30 INFO - ], 14:39:30 INFO - "repository": "", 14:39:30 INFO - "rev": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3", 14:39:30 INFO - "who": "kwierso@gmail.com", 14:39:30 INFO - "when": 1451947104, 14:39:30 INFO - "number": 7414726, 14:39:30 INFO - "comments": "Bug 1230686 - use RefPtr& instead of DrawTarget* to track changes in SurfaceFromElement a=ritu", 14:39:30 INFO - "project": "", 14:39:30 INFO - "at": "Mon 04 Jan 2016 14:38:24", 14:39:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 14:39:30 INFO - "revlink": "", 14:39:30 INFO - "properties": [ 14:39:30 INFO - [ 14:39:30 INFO - "buildid", 14:39:30 INFO - "20160104121333", 14:39:30 INFO - "Change" 14:39:30 INFO - ], 14:39:30 INFO - [ 14:39:30 INFO - "builduid", 14:39:30 INFO - "06de634a43b5417c8c6707855fa32313", 14:39:30 INFO - "Change" 14:39:30 INFO - ], 14:39:30 INFO - [ 14:39:30 INFO - "pgo_build", 14:39:30 INFO - "True", 14:39:30 INFO - "Change" 14:39:30 INFO - ] 14:39:30 INFO - ], 14:39:30 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 14:39:30 INFO - } 14:39:30 INFO - ], 14:39:30 INFO - "revision": "45faafefe2f8416b8d286d20c94ce9b2ddef03c3" 14:39:30 INFO - } 14:39:30 INFO - } 14:39:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 14:39:30 INFO - Running post-action listener: _resource_record_post_action 14:39:30 INFO - ##### 14:39:30 INFO - ##### Running download-and-extract step. 14:39:30 INFO - ##### 14:39:30 INFO - Running pre-action listener: _resource_record_pre_action 14:39:30 INFO - Running main action method: download_and_extract 14:39:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:39: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')]} 14:39:30 INFO - https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/test_packages.json 14:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/test_packages.json 14:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:39:31 INFO - Downloaded 1302 bytes. 14:39:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:39:31 INFO - Using the following test package requirements: 14:39:31 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:31 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:31 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'jsshell-linux-x86_64.zip'], 14:39:31 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:31 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:31 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:39:31 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:39:31 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:31 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 14:39:31 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 14:39:31 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:31 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:31 INFO - https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:32 INFO - Downloaded 23023959 bytes. 14:39:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:39:33 INFO - Return code: 0 14:39:33 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:33 INFO - https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:39:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:38 INFO - Downloaded 23023959 bytes. 14:39:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 14:39:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:39:40 INFO - Return code: 0 14:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:40 INFO - https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:41 INFO - Downloaded 11132038 bytes. 14:39:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:39:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 14:39:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:39:41 INFO - Return code: 0 14:39: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')]} 14:39:41 INFO - https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:39:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 14:39:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 14:39:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 14:39:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:39:43 INFO - Downloaded 58102614 bytes. 14:39:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 14:39:43 INFO - mkdir: /builds/slave/test-pgo/properties 14:39:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:39:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:39:43 INFO - Contents: 14:39:43 INFO - build_url:https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 14:39:43 INFO - Running post-action listener: _resource_record_post_action 14:39:43 INFO - Running post-action listener: set_extra_try_arguments 14:39:43 INFO - ##### 14:39:43 INFO - ##### Running populate-webroot step. 14:39:43 INFO - ##### 14:39:43 INFO - Running pre-action listener: _resource_record_pre_action 14:39:43 INFO - Running main action method: populate_webroot 14:39:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:43 INFO - '--tppagecycles', 14:39:43 INFO - '7'], 14:39:43 INFO - 'tests': ['tsvgm']}}, 14:39:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:39:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:39:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:39:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'tests': ['damp', 'tps']}, 14:39:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['damp', 'tps']}, 14:39:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:39:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:43 INFO - 'other': {'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'other_l64': {'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'other_nol64': {'tests': ['a11yr', 14:39:43 INFO - 'ts_paint', 14:39:43 INFO - 'tpaint', 14:39:43 INFO - 'sessionrestore', 14:39:43 INFO - 'sessionrestore_no_auto_restore']}, 14:39:43 INFO - 'svgr': {'tests': ['tsvgx', 14:39:43 INFO - 'tsvgr_opacity', 14:39:43 INFO - 'tart', 14:39:43 INFO - 'tscrollx', 14:39:43 INFO - 'cart']}, 14:39:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['tsvgx', 14:39:43 INFO - 'tsvgr_opacity', 14:39:43 INFO - 'tart', 14:39:43 INFO - 'tscrollx', 14:39:43 INFO - 'cart']}, 14:39:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'tests': ['tp5o']}, 14:39:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'talos_options': ['--e10s'], 14:39:43 INFO - 'tests': ['tp5o']}, 14:39:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'talos_options': ['--xperf_path', 14:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:43 INFO - 'tests': ['tp5n']}, 14:39:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:43 INFO - 'talos_options': ['--e10s', 14:39:43 INFO - '--xperf_path', 14:39:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:43 INFO - 'tests': ['tp5n']}}, 14:39:43 INFO - 'talos.zip': {'path': '', 14:39:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:43 INFO - Running post-action listener: _resource_record_post_action 14:39:43 INFO - ##### 14:39:43 INFO - ##### Running create-virtualenv step. 14:39:43 INFO - ##### 14:39:43 INFO - Running pre-action listener: _resource_record_pre_action 14:39:43 INFO - Running main action method: create_virtualenv 14:39:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:39:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:39:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:39:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:43 INFO - Using real prefix '/usr' 14:39:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:39:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:45 INFO - Installing pip.................done. 14:39:45 INFO - Return code: 0 14:39:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:39:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:39:45 INFO - Using env: {'DISPLAY': ':0', 14:39:45 INFO - 'HOME': '/home/cltbld', 14:39:45 INFO - 'LANG': 'en_US.UTF-8', 14:39:45 INFO - 'LANGUAGE': 'en_US:en', 14:39:45 INFO - 'LOGNAME': 'cltbld', 14:39:45 INFO - 'MAIL': '/var/mail/cltbld', 14:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:45 INFO - 'MOZ_NO_REMOTE': '1', 14:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:45 INFO - 'NO_EM_RESTART': '1', 14:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:45 INFO - 'SHELL': '/bin/bash', 14:39:45 INFO - 'SHLVL': '1', 14:39:45 INFO - 'TERM': 'linux', 14:39:45 INFO - 'TMOUT': '86400', 14:39:45 INFO - 'USER': 'cltbld', 14:39:45 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:45 INFO - '_': '/tools/buildbot/bin/python'} 14:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:39:45 INFO - Cleaning up... 14:39:45 INFO - Return code: 0 14:39:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:39:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:39:45 INFO - Using env: {'DISPLAY': ':0', 14:39:45 INFO - 'HOME': '/home/cltbld', 14:39:45 INFO - 'LANG': 'en_US.UTF-8', 14:39:45 INFO - 'LANGUAGE': 'en_US:en', 14:39:45 INFO - 'LOGNAME': 'cltbld', 14:39:45 INFO - 'MAIL': '/var/mail/cltbld', 14:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:45 INFO - 'MOZ_NO_REMOTE': '1', 14:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:45 INFO - 'NO_EM_RESTART': '1', 14:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:45 INFO - 'SHELL': '/bin/bash', 14:39:45 INFO - 'SHLVL': '1', 14:39:45 INFO - 'TERM': 'linux', 14:39:45 INFO - 'TMOUT': '86400', 14:39:45 INFO - 'USER': 'cltbld', 14:39:45 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:45 INFO - '_': '/tools/buildbot/bin/python'} 14:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:46 INFO - Downloading/unpacking psutil>=0.7.1 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:39:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:39:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:47 INFO - Installing collected packages: psutil 14:39:47 INFO - Running setup.py install for psutil 14:39:48 INFO - building 'psutil._psutil_linux' extension 14:39:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:39:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:39:48 INFO - building 'psutil._psutil_posix' extension 14:39:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:39:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:39:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:48 INFO - Successfully installed psutil 14:39:48 INFO - Cleaning up... 14:39:48 INFO - Return code: 0 14:39:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:39:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:39:48 INFO - Using env: {'DISPLAY': ':0', 14:39:48 INFO - 'HOME': '/home/cltbld', 14:39:48 INFO - 'LANG': 'en_US.UTF-8', 14:39:48 INFO - 'LANGUAGE': 'en_US:en', 14:39:48 INFO - 'LOGNAME': 'cltbld', 14:39:48 INFO - 'MAIL': '/var/mail/cltbld', 14:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:48 INFO - 'MOZ_NO_REMOTE': '1', 14:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:48 INFO - 'NO_EM_RESTART': '1', 14:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:48 INFO - 'SHELL': '/bin/bash', 14:39:48 INFO - 'SHLVL': '1', 14:39:48 INFO - 'TERM': 'linux', 14:39:48 INFO - 'TMOUT': '86400', 14:39:48 INFO - 'USER': 'cltbld', 14:39:48 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:48 INFO - '_': '/tools/buildbot/bin/python'} 14:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:39:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:50 INFO - Installing collected packages: mozsystemmonitor 14:39:50 INFO - Running setup.py install for mozsystemmonitor 14:39:50 INFO - Successfully installed mozsystemmonitor 14:39:50 INFO - Cleaning up... 14:39:50 INFO - Return code: 0 14:39:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:39:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:39:50 INFO - Using env: {'DISPLAY': ':0', 14:39:50 INFO - 'HOME': '/home/cltbld', 14:39:50 INFO - 'LANG': 'en_US.UTF-8', 14:39:50 INFO - 'LANGUAGE': 'en_US:en', 14:39:50 INFO - 'LOGNAME': 'cltbld', 14:39:50 INFO - 'MAIL': '/var/mail/cltbld', 14:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:50 INFO - 'MOZ_NO_REMOTE': '1', 14:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:50 INFO - 'NO_EM_RESTART': '1', 14:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:50 INFO - 'SHELL': '/bin/bash', 14:39:50 INFO - 'SHLVL': '1', 14:39:50 INFO - 'TERM': 'linux', 14:39:50 INFO - 'TMOUT': '86400', 14:39:50 INFO - 'USER': 'cltbld', 14:39:50 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:50 INFO - '_': '/tools/buildbot/bin/python'} 14:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:39:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:39:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:39:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:53 INFO - Downloading docopt-0.6.1.tar.gz 14:39:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:39:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:53 INFO - Running setup.py install for blobuploader 14:39:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:39:53 INFO - Running setup.py install for requests 14:39:53 INFO - Running setup.py install for docopt 14:39:53 INFO - Successfully installed blobuploader requests docopt 14:39:53 INFO - Cleaning up... 14:39:53 INFO - Return code: 0 14:39:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:39:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:53 INFO - Using env: {'DISPLAY': ':0', 14:39:53 INFO - 'HOME': '/home/cltbld', 14:39:53 INFO - 'LANG': 'en_US.UTF-8', 14:39:53 INFO - 'LANGUAGE': 'en_US:en', 14:39:53 INFO - 'LOGNAME': 'cltbld', 14:39:53 INFO - 'MAIL': '/var/mail/cltbld', 14:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:53 INFO - 'MOZ_NO_REMOTE': '1', 14:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:53 INFO - 'NO_EM_RESTART': '1', 14:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:53 INFO - 'SHELL': '/bin/bash', 14:39:53 INFO - 'SHLVL': '1', 14:39:53 INFO - 'TERM': 'linux', 14:39:53 INFO - 'TMOUT': '86400', 14:39:53 INFO - 'USER': 'cltbld', 14:39:53 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:53 INFO - '_': '/tools/buildbot/bin/python'} 14:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:54 INFO - Running setup.py (path:/tmp/pip-5d6WpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:54 INFO - Running setup.py (path:/tmp/pip-VwDWTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:54 INFO - Running setup.py (path:/tmp/pip-Vb6o9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:54 INFO - Running setup.py (path:/tmp/pip-MKLNdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:54 INFO - Running setup.py (path:/tmp/pip-FB8SnA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:54 INFO - Running setup.py (path:/tmp/pip-LAbk4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:54 INFO - Running setup.py (path:/tmp/pip-RBGNOm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:54 INFO - Running setup.py (path:/tmp/pip-VWwBJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:54 INFO - Running setup.py (path:/tmp/pip-bNZE0o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:54 INFO - Running setup.py (path:/tmp/pip-uwUhZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:54 INFO - Running setup.py (path:/tmp/pip-4uCKUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:54 INFO - Running setup.py (path:/tmp/pip-F9LXmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:54 INFO - Running setup.py (path:/tmp/pip-inJvqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:54 INFO - Running setup.py (path:/tmp/pip-nVx9JL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:55 INFO - Running setup.py (path:/tmp/pip-q5YyYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:55 INFO - Running setup.py (path:/tmp/pip-ZG5weu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:55 INFO - Running setup.py (path:/tmp/pip-KYIGBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:55 INFO - Running setup.py install for manifestparser 14:39:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:39:55 INFO - Running setup.py install for mozcrash 14:39:55 INFO - Running setup.py install for mozdebug 14:39:55 INFO - Running setup.py install for mozdevice 14:39:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:39:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:39:55 INFO - Running setup.py install for mozfile 14:39:55 INFO - Running setup.py install for mozhttpd 14:39:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:39:55 INFO - Running setup.py install for mozinfo 14:39:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:39:55 INFO - Running setup.py install for mozInstall 14:39:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Running setup.py install for mozleak 14:39:56 INFO - Running setup.py install for mozlog 14:39:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Running setup.py install for moznetwork 14:39:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Running setup.py install for mozprocess 14:39:56 INFO - Running setup.py install for mozprofile 14:39:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Running setup.py install for mozrunner 14:39:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:39:56 INFO - Running setup.py install for mozscreenshot 14:39:56 INFO - Running setup.py install for moztest 14:39:56 INFO - Running setup.py install for mozversion 14:39:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:39:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:57 INFO - Cleaning up... 14:39:57 INFO - Return code: 0 14:39:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:39:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:39:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:39:57 INFO - Using env: {'DISPLAY': ':0', 14:39:57 INFO - 'HOME': '/home/cltbld', 14:39:57 INFO - 'LANG': 'en_US.UTF-8', 14:39:57 INFO - 'LANGUAGE': 'en_US:en', 14:39:57 INFO - 'LOGNAME': 'cltbld', 14:39:57 INFO - 'MAIL': '/var/mail/cltbld', 14:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:57 INFO - 'MOZ_NO_REMOTE': '1', 14:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:57 INFO - 'NO_EM_RESTART': '1', 14:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:39:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:39:57 INFO - 'SHELL': '/bin/bash', 14:39:57 INFO - 'SHLVL': '1', 14:39:57 INFO - 'TERM': 'linux', 14:39:57 INFO - 'TMOUT': '86400', 14:39:57 INFO - 'USER': 'cltbld', 14:39:57 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:57 INFO - '_': '/tools/buildbot/bin/python'} 14:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:57 INFO - Running setup.py (path:/tmp/pip-AkDW_h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:57 INFO - Running setup.py (path:/tmp/pip-x38TW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:57 INFO - Running setup.py (path:/tmp/pip-pj54Rj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:57 INFO - Running setup.py (path:/tmp/pip-Od7dtL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:57 INFO - Running setup.py (path:/tmp/pip-xn0Xqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:57 INFO - Running setup.py (path:/tmp/pip-nwN9h4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:57 INFO - Running setup.py (path:/tmp/pip-11lZG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:57 INFO - Running setup.py (path:/tmp/pip-8bQfeE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:57 INFO - Running setup.py (path:/tmp/pip-QztWKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:57 INFO - Running setup.py (path:/tmp/pip-lvY41U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:58 INFO - Running setup.py (path:/tmp/pip-RyrQU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:58 INFO - Running setup.py (path:/tmp/pip-fqNuu7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:58 INFO - Running setup.py (path:/tmp/pip-L21BF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:58 INFO - Running setup.py (path:/tmp/pip-YyHFdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:58 INFO - Running setup.py (path:/tmp/pip-FWil_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:58 INFO - Running setup.py (path:/tmp/pip-PuShUm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:39:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:58 INFO - Running setup.py (path:/tmp/pip-vcTQ5x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:00 INFO - Downloading blessings-1.5.1.tar.gz 14:40:00 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:40:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:00 INFO - Installing collected packages: blessings 14:40:00 INFO - Running setup.py install for blessings 14:40:00 INFO - Successfully installed blessings 14:40:00 INFO - Cleaning up... 14:40:00 INFO - Return code: 0 14:40:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:40:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:40:00 INFO - Reading from file tmpfile_stdout 14:40:00 INFO - Current package versions: 14:40:00 INFO - argparse == 1.2.1 14:40:00 INFO - blessings == 1.5.1 14:40:00 INFO - blobuploader == 1.2.4 14:40:00 INFO - docopt == 0.6.1 14:40:00 INFO - manifestparser == 1.1 14:40:00 INFO - mozInstall == 1.12 14:40:00 INFO - mozcrash == 0.16 14:40:00 INFO - mozdebug == 0.1 14:40:00 INFO - mozdevice == 0.47 14:40:00 INFO - mozfile == 1.2 14:40:00 INFO - mozhttpd == 0.7 14:40:00 INFO - mozinfo == 0.9 14:40:00 INFO - mozleak == 0.1 14:40:00 INFO - mozlog == 3.1 14:40:00 INFO - moznetwork == 0.27 14:40:00 INFO - mozprocess == 0.22 14:40:00 INFO - mozprofile == 0.27 14:40:00 INFO - mozrunner == 6.11 14:40:00 INFO - mozscreenshot == 0.1 14:40:00 INFO - mozsystemmonitor == 0.0 14:40:00 INFO - moztest == 0.7 14:40:00 INFO - mozversion == 1.4 14:40:00 INFO - psutil == 3.1.1 14:40:00 INFO - requests == 1.2.3 14:40:00 INFO - wsgiref == 0.1.2 14:40:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:40:00 INFO - Using env: {'DISPLAY': ':0', 14:40:00 INFO - 'HOME': '/home/cltbld', 14:40:00 INFO - 'LANG': 'en_US.UTF-8', 14:40:00 INFO - 'LANGUAGE': 'en_US:en', 14:40:00 INFO - 'LOGNAME': 'cltbld', 14:40:00 INFO - 'MAIL': '/var/mail/cltbld', 14:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:00 INFO - 'MOZ_NO_REMOTE': '1', 14:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:00 INFO - 'NO_EM_RESTART': '1', 14:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:40:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:40:00 INFO - 'SHELL': '/bin/bash', 14:40:00 INFO - 'SHLVL': '1', 14:40:00 INFO - 'TERM': 'linux', 14:40:00 INFO - 'TMOUT': '86400', 14:40:00 INFO - 'USER': 'cltbld', 14:40:00 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:00 INFO - '_': '/tools/buildbot/bin/python'} 14:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:00 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 1)) 14:40:00 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 2)) 14:40:00 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 3)) 14:40:00 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 4)) 14:40:00 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 5)) 14:40:00 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 6)) 14:40:00 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 7)) 14:40:00 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 8)) 14:40:00 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:40:00 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 3)) 14:40:00 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:40:00 INFO - Cleaning up... 14:40:00 INFO - Return code: 0 14:40:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:40:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:40:00 INFO - Using env: {'DISPLAY': ':0', 14:40:00 INFO - 'HOME': '/home/cltbld', 14:40:00 INFO - 'LANG': 'en_US.UTF-8', 14:40:00 INFO - 'LANGUAGE': 'en_US:en', 14:40:00 INFO - 'LOGNAME': 'cltbld', 14:40:00 INFO - 'MAIL': '/var/mail/cltbld', 14:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:00 INFO - 'MOZ_NO_REMOTE': '1', 14:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:00 INFO - 'NO_EM_RESTART': '1', 14:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:40:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:40:00 INFO - 'SHELL': '/bin/bash', 14:40:00 INFO - 'SHLVL': '1', 14:40:00 INFO - 'TERM': 'linux', 14:40:00 INFO - 'TMOUT': '86400', 14:40:00 INFO - 'USER': 'cltbld', 14:40:00 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:00 INFO - '_': '/tools/buildbot/bin/python'} 14:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:01 INFO - Downloading/unpacking jsonschema 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:40:02 INFO - Downloading/unpacking functools32 (from jsonschema) 14:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:40:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:03 INFO - warning: no files found matching '*.txt' 14:40:03 INFO - no previously-included directories found matching 'build' 14:40:03 INFO - no previously-included directories found matching 'dist' 14:40:03 INFO - no previously-included directories found matching '.git*' 14:40:03 INFO - Installing collected packages: jsonschema, functools32 14:40:03 INFO - Running setup.py install for functools32 14:40:03 INFO - warning: no files found matching '*.txt' 14:40:03 INFO - no previously-included directories found matching 'build' 14:40:03 INFO - no previously-included directories found matching 'dist' 14:40:03 INFO - no previously-included directories found matching '.git*' 14:40:03 INFO - Successfully installed jsonschema functools32 14:40:03 INFO - Cleaning up... 14:40:03 INFO - Return code: 0 14:40:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05df38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2779450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, '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-1451947017.958261-1291483555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:40:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:40:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:40:03 INFO - Using env: {'DISPLAY': ':0', 14:40:03 INFO - 'HOME': '/home/cltbld', 14:40:03 INFO - 'LANG': 'en_US.UTF-8', 14:40:03 INFO - 'LANGUAGE': 'en_US:en', 14:40:03 INFO - 'LOGNAME': 'cltbld', 14:40:03 INFO - 'MAIL': '/var/mail/cltbld', 14:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:03 INFO - 'MOZ_NO_REMOTE': '1', 14:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:03 INFO - 'NO_EM_RESTART': '1', 14:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:40:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:40:03 INFO - 'SHELL': '/bin/bash', 14:40:03 INFO - 'SHLVL': '1', 14:40:03 INFO - 'TERM': 'linux', 14:40:03 INFO - 'TMOUT': '86400', 14:40:03 INFO - 'USER': 'cltbld', 14:40:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:03 INFO - '_': '/tools/buildbot/bin/python'} 14:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:03 INFO - Downloading/unpacking flake8 14:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:40:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:40:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:40:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:40:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:40:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:40:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:05 INFO - no previously-included directories found matching 'docs/_build' 14:40:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:40:05 INFO - Running setup.py install for pep8 14:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:05 INFO - no previously-included directories found matching 'docs/_build' 14:40:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:40:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:40:05 INFO - Cleaning up... 14:40:06 INFO - Return code: 0 14:40:06 INFO - Running post-action listener: _resource_record_post_action 14:40:06 INFO - Running post-action listener: _start_resource_monitoring 14:40:06 INFO - Starting resource monitoring. 14:40:06 INFO - ##### 14:40:06 INFO - ##### Running install step. 14:40:06 INFO - ##### 14:40:06 INFO - Running pre-action listener: _resource_record_pre_action 14:40:06 INFO - Running main action method: install 14:40:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:40:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:40:06 INFO - Reading from file tmpfile_stdout 14:40:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:40:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:40:06 INFO - Reading from file tmpfile_stdout 14:40:06 INFO - Output received: 14:40:06 INFO - Usage: mozinstall [options] installer 14:40:06 INFO - Options: 14:40:06 INFO - -h, --help show this help message and exit 14:40:06 INFO - -d DEST, --destination=DEST 14:40:06 INFO - Directory to install application into. [default: 14:40:06 INFO - "/builds/slave/test-pgo"] 14:40:06 INFO - --app=APP Application being installed. [default: firefox] 14:40:06 INFO - mkdir: /builds/slave/test-pgo/build/application 14:40:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:40:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:40:20 INFO - Reading from file tmpfile_stdout 14:40:20 INFO - Output received: 14:40:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:40:20 INFO - Running post-action listener: _resource_record_post_action 14:40:20 INFO - ##### 14:40:20 INFO - ##### Running run-tests step. 14:40:20 INFO - ##### 14:40:20 INFO - Running pre-action listener: _resource_record_pre_action 14:40:20 INFO - Running main action method: run_tests 14:40:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:40:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:40:20 INFO - Python 2.7.3 14:40:20 INFO - Return code: 0 14:40:20 INFO - grabbing minidump binary from tooltool 14:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:20 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 0x280ba50>, '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 0x2777550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27779e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:40:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:40:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:40:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:20 INFO - Return code: 0 14:40:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:40:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:40:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:40:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:40:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:40:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:40:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:40:21 INFO - Return code: 0 14:40:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:40:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 14:40:21 INFO - Using env: {'DISPLAY': ':0', 14:40:21 INFO - 'HOME': '/home/cltbld', 14:40:21 INFO - 'LANG': 'en_US.UTF-8', 14:40:21 INFO - 'LANGUAGE': 'en_US:en', 14:40:21 INFO - 'LOGNAME': 'cltbld', 14:40:21 INFO - 'MAIL': '/var/mail/cltbld', 14:40:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:40:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:21 INFO - 'MOZ_NO_REMOTE': '1', 14:40:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:21 INFO - 'NO_EM_RESTART': '1', 14:40:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:40:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:40:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:40:21 INFO - 'SHELL': '/bin/bash', 14:40:21 INFO - 'SHLVL': '1', 14:40:21 INFO - 'TERM': 'linux', 14:40:21 INFO - 'TMOUT': '86400', 14:40:21 INFO - 'USER': 'cltbld', 14:40:21 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1451947017.958261-1291483555', 14:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:21 INFO - '_': '/tools/buildbot/bin/python'} 14:40:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 14:40:22 INFO - mozversion INFO | application_buildid: 20160104121333 14:40:22 INFO - mozversion INFO | application_changeset: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 14:40:22 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:40:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:22 INFO - mozversion INFO | application_name: Firefox 14:40:22 INFO - mozversion INFO | application_remotingname: firefox-dev 14:40:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:22 INFO - mozversion INFO | application_vendor: Mozilla 14:40:22 INFO - mozversion INFO | application_version: 45.0a2 14:40:22 INFO - mozversion INFO | platform_buildid: 20160104121333 14:40:22 INFO - mozversion INFO | platform_changeset: 45faafefe2f8416b8d286d20c94ce9b2ddef03c3 14:40:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:40:22 INFO - mozversion INFO | platform_version: 45.0a2 14:40:22 INFO - 2016-01-04 14:40:22,083 DEBUG : using testdate: 1451947222 14:40:22 INFO - 2016-01-04 14:40:22,083 DEBUG : actual date: 1451947222 14:40:22 INFO - 2016-01-04 14:40:22,174 INFO : starting webserver on 'localhost:50798' 14:40:22 INFO - 2016-01-04 14:40:22,175 INFO : Starting test suite talos-linux64-ix-049.e 14:40:22 INFO - 2016-01-04 14:40:22,175 INFO : Starting test dromaeo_css 14:40:22 INFO - 2016-01-04 14:40:22,176 DEBUG : operating with platform_type : linux_ 14:40:22 INFO - 2016-01-04 14:40:22,176 INFO : Initialising browser for dromaeo_css test... 14:40:22 INFO - 2016-01-04 14:40:22,193 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnWA2F9/profile http://localhost:50798/getInfo.html 14:40:26 INFO - 2016-01-04 14:40:26,416 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:40:26 INFO - 2016-01-04 14:40:26,416 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:40:26 INFO - 2016-01-04 14:40:26,416 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:40:26 INFO - 2016-01-04 14:40:26,417 DEBUG : BROWSER_OUTPUT: __metrics 14:40:27 INFO - 2016-01-04 14:40:27,421 INFO : Browser initialized. 14:40:27 INFO - 2016-01-04 14:40:27,422 INFO : Running cycle 1/1 for dromaeo_css test... 14:40:27 INFO - 2016-01-04 14:40:27,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnWA2F9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:40:39 INFO - 2016-01-04 14:40:39,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 136687616 14:40:39 INFO - 2016-01-04 14:40:39,239 DEBUG : BROWSER_OUTPUT: 14:41:28 INFO - 2016-01-04 14:41:28,840 DEBUG : BROWSER_OUTPUT: 1451947288837 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:43:36 INFO - 2016-01-04 14:43:36,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50798/tests/dromaeo/cssquery-ext.html) 14:43:37 INFO - 2016-01-04 14:43:37,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 142110720 14:43:37 INFO - 2016-01-04 14:43:37,570 DEBUG : BROWSER_OUTPUT: 14:46:39 INFO - 2016-01-04 14:46:39,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-ext.html (next: http://localhost:50798/tests/dromaeo/cssquery-jquery.html) 14:46:39 INFO - 2016-01-04 14:46:39,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 140320768 14:46:39 INFO - 2016-01-04 14:46:39,924 DEBUG : BROWSER_OUTPUT: 14:49:41 INFO - 2016-01-04 14:49:41,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50798/tests/dromaeo/cssquery-mootools.html) 14:49:42 INFO - 2016-01-04 14:49:42,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 139902976 14:49:42 INFO - 2016-01-04 14:49:42,065 DEBUG : BROWSER_OUTPUT: 14:52:43 INFO - 2016-01-04 14:52:43,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50798/tests/dromaeo/cssquery-prototype.html) 14:52:44 INFO - 2016-01-04 14:52:44,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 140201984 14:52:44 INFO - 2016-01-04 14:52:44,231 DEBUG : BROWSER_OUTPUT: 14:55:46 INFO - 2016-01-04 14:55:46,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50798/tests/dromaeo/cssquery-yui.html) 14:55:47 INFO - 2016-01-04 14:55:47,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 139829248 14:55:47 INFO - 2016-01-04 14:55:47,023 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/dromaeo/cssquery-yui.html (next: http://localhost:50798/tests/dromaeo/cssquery-dojo.html) 14:58:49 INFO - 2016-01-04 14:58:49,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 141541376 14:58:49 INFO - 2016-01-04 14:58:49,379 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,381 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:58:49 INFO - 2016-01-04 14:58:49,381 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:58:49 INFO - 2016-01-04 14:58:49,381 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:58:49 INFO - 2016-01-04 14:58:49,381 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:58:49 INFO - 2016-01-04 14:58:49,383 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3283.7044665980056;3287.5233091201776;3306.404847127516;3328.6671332866717;3350.363430948119;5385.5960802939835;5420.349558053034;5421.186821976706;5428.805662754193;5467.015937131315;5424.945750542493;5458.6724796512135;5458.972705136479;5464.371597266306;5475.863103422416;4969.031038947407;4998.775055122519;5031.547160755531;5041.72270525121;5071.670341427814;4945.975270123644;5041.773120209581;5101.591872650198;5104.259882317062;5107.923381149286;5047.116754567955;5059.898802023958;5129.871753206181;5135.460776618457;5152.51051150142;5091.083604951107;5171.974140129313;5179.14544100223;5179.637425380225;5205.791768329263;4797.304390863305;4920.409550853885;5025.547700706954;5076.187809950427;5077.339945807058;5349.331333583302;5425.240466334716;5426.050441172819;5443.129099344086;5471.288732464794;6012.368701286389;6042.154098426224;6094.451499365078;6098.664573448458;6107.938920610782;5769.884602307972;5921.052631578969;6004.219451471325;6053.7578496860515;6114.175715401369;5613.663180209201;5682.51698605619;5688.488036076773;5697.829065128053;5708.229389032469;6101.450869421773;6138.539609529304;6153.1693221415435;6154.938450615526;6167.352427995085;5784.566157538202;5906.49794767441;5908.586398952032;5910.734016969247;5915.497182739516;5712.285964254468;5796.5072968797285;5989.970050149808;6123.374132580163;6129.295131059986;5859.033259512218;5885.058390657474;5890.469857712741;5905.291365036223;5906.7637294508595;5705.71471426427;5918.112283157561;5931.555133364928;5941.58408911372;5955.106733989936;4514.164879497303;4565.977170114194;4572.4055872737;4596.057808149321;4604.447466303998;4096.979515102465;4112.588741125864;4119.588041195856;4147.834086636501;4169.791510424467;5506.944930550643;5623.775048997994;5703.201551782754;5717.542596592262;5718.085106382959;5986.132010858401;6057.3336932937345;6128.080787881764;6130.612163469634;6131.040261761288;5539.279893613804;5588.1059030555725;5590.552755779528;5598.1322894951345;5607.775688972395;5055.974720126376;5087.084324821493;5134.974325128425;5155.252488389163;5167.612429067835;5946.197263369476;6066.605670631395;6101.877962440726;6106.389361063858;6106.664133472702;5864.501517371071;5907.202527658711;5919.023361145363;5929.970350148395;5931.495822855106;6067.24159480065;6081.996470582304;6088.756449741961;6098.115773212948;6205.906911396242;6003.759849605967;6037;6044.818655440344;6058.485028772604;6060.363661815446;6097.725602347817;6129.632222066691;6130.356312587114;6136.754529818757;6146.108814222002;5656.3495198051105;5737.942620573741;5745.597808153389;5863.120531920246;5965.105234214729;5725.971370143123;5907.91138132937;5916.378780228014;5921.5558833086825;5922.703864806828;5749.108888122348;5821.068629019336;5822.039363504974;5831.70841457917;5840.357560668408;5526.419725928719;5543.1685247213245;5655.066913959151;5704.885902281848;5724.656520608777;5508;5733.942660573341;5814.592978491465;5826.563007774349;5827.067669172912 14:58:49 INFO - 2016-01-04 14:58:49,384 DEBUG : BROWSER_OUTPUT: |1;ext.html;622.7042154976386;628.1708145248273;667.4526887951878;668.7394261816474;687.2200052939912;40458.59541404585;41583;41915.79042104789;41930;42073.15853682924;44997.77501112498;45717;45828.770856145675;45871.31193032107;45906.540934590645;8673.91326086739;8773.16654917785;8817.73546793594;8857.202851743341;8865.689700860472;8558.52928088958;8620.741377758646;8651.524166170859;8710.869336959951;8722.476651400904;8664.696735614254;8745.43154694946;8753.956230218871;8769.605367758466;8812.735617931472;8600.612972416257;8641.438306510057;8675.436096653697;8678.86981695275;8700.26047785939;8537.274331681814;8632.611532481053;8646.394752367336;8682.13178682133;8691.39160258782;42940.3558946616;43227.919302017384;43307.56692433098;43348.349774753086;43511.34732979008;3418.265073009315;3427.143214196451;3459.6713312235297;3516.3670539302916;4184.184084103601;31655.683443165504;32077.51883721746;32360.35279294401;32606;32849;3947.782871942042;4021.356582946744;4061.756294622332;4086.244044851712;4126.257273690734;291852;292112;292361.99999999785;293385;296324;43978.56021439745;44321.335179972324;64946;65155.674221628586;65344.673276633315;42447.787761060994;42699.7865010673;42720.78639606782;42962.78518607449;42968.14063718771;14905.70188596222;15006.849931500763;15037.699246015018;15079.623009424851;15101;11598.420078996185;11610.187286890006;11622.07023438123;11638.243514171552;11681.065514758799;14786.630334241514;15440.691186176213;15453.227338633023;15490.380384784483;15529.844701553066;6117.143599896018;6259.342769009279;6328.6202827830475;6359.3640635936035;6372.681365931685;1011.8482227665909;1042.8852826189113;1052.1057101463696;1053.9683809485728;1085.804555180075;28603.28491787722;28614.570781438295;28824.279393015342;29063.56404653932;29296.853515732284;1115.66530040989;1131.813250813623;1174;1230.7046308885804;1250.8936740376987;17128;17892;17905.641887162183;18160.273589056553;18189.63620727578;414849;760320;788343;794940;805685.9715701501;59142.70428647829;60162.699186504666;60304;60498;60536.09195862066;1457.8396376398587;1491.2394678713717;1493.2906869237243;1495.7008598280388;1506.4049700368294;30089.398212036074;30390.84804575963;30478.54793713821;31362.68637313689;31628;46882;47120.528794711616;47382.28926566035;47500.52499474961;47570.762146189045;317707;319363;319441;320483;320797;34157;48609;48781.756091219315;48974;49486.50513494819;44489;45110.77444612756;45674.54325456703;45927.54072459233;45928.31107533323;37950.240995180495;38613.61386386213;39023.2195356097;39218.21563568655;39715.80142099386;38959.415608765325;39181.80409097936;39781.40327895026;39812;39887.40168897527;44019.11961760811;44201;44264;45135.32297015482;45513.54486455093;33689.66310336865;33768;34214.31571368608;34223.657763422045;34659.653403466655;26665.066722664615;27669;28326;30352;31158.688413116484 14:58:49 INFO - 2016-01-04 14:58:49,385 DEBUG : BROWSER_OUTPUT: |2;jquery.html;394.5265681182582;395.36938582960204;397.4852565927125;398.279114802208;399.03831765445284;15013.849861501381;16186;16726.996380217195;17314.740278895828;17351.30594776209;11788.233764805304;12149.331786751725;12153.939230303837;17110.058946757956;18454.815451845476;5011.874703132415;5096.8470945871495;5112.36095488064;5116.769745361467;5321.866953326159;5323.041852466555;5418.078926582491;5453.972730136344;5476.945230547703;5477.452254774531;5396.325459317585;5446.618736688433;5457.208704737811;5856.824295271127;6114.144019837227;6174.598651087687;6176.197094377747;6177.722002509875;6178.721957511878;6180.134781130645;5214.97392513035;5340.385855626614;5350.357957045179;5501.972490137564;5515.393306736256;13321.933390333083;13413.731725365438;13465.730685386336;17863.374781882572;20485.897570512054;1954.9315773947844;2024.44327809852;2043.5606344635974;2054.578811343671;2161.0599389265562;9693.806123877483;9840.311178217527;10100.545475453622;10110.331795253775;10180.38917664935;1852.685043542601;1884.896330701811;1910.866239363245;1927.5662975830467;1930.7007413850736;61248.69375653138;62715.6864215676;63532;63825;65091.67454162699;10970.067544258827;10986.08143459064;11004.614838480775;11113.94443027796;11115.388653623966;14247.358868850926;14253.78842798353;14315.21266330341;14330.140191588538;14358.856411435752;8115.8782618260775;8128.309093726981;8169;8182.590870456454;8188.754337369888;7815.68737250515;7830.099538553025;7848.882266766003;7875.56684382353;7879.251471110236;4618.376519169936;4752.619790416758;4763.3807605011125;4842;4862.756862156878;1904.1431355889904;1957.354073155855;1986;2008.4677560446494;2014.2345908554948;897.9955100224588;996.7159359582629;1059.89930956559;1067.7330667333167;1113.1984970820995;17080.302916697758;17754.467365979042;18018.729719054223;18103.275868965356;18268.63462730738;966.9613215471302;972.9367591106555;1032.385730490357;1056.6354607660344;1059.4490864750287;10102.747431314276;10423.895761042444;10434.269601127848;10510.894891051144;10575.312604680825;483437;619627;621294;622926;624927;82545.17454825375;82620;82939.58530207431;84440.15559844446;84559.57720211359;1173.4015652017533;1195.2589394575418;1207.269601890861;1210.8183772434206;1227.300438749904;16625;16793.74809377836;16866.578335541708;17012.74480882763;17081.572960675585;33023.174420639676;33104;33165.83417082899;34854.12864678403;37576.248475030894;43905;46255;47290.52709472861;47347.76326118485;49676.25485617791;9891.950540247253;10100.393976361442;10611;10645.041946224877;10656.89343106559;17733.113344332472;17781.46655600334;17994.91002544979;18199.818001820342;18583.907080464513;13214.207147571176;13663.18020918748;13752.31238438094;14683.706325873636;14933;14717.55847324582;14798.778018329518;14987.325570349143;15019.09885406879;15383.077015379113;15238.085714857145;15280.083195008336;15289.847101528841;15578.143202123993;15625.218739062773;9765.2676049298;9908.603655853685;10106;10191.694249172537;10201.489925503844;10826.837597435888;14623.853761462675;15536;15787.368505259661;15927.283272252545 14:58:49 INFO - 2016-01-04 14:58:49,387 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1537.9538613841585;1577.195630228583;1613.4111049466944;1804.1700817623891;1877.164661725532;7915.366770658348;7955.801104972378;7973.40199485038;8111.472754270975;8135.837283254339;8057.516549007064;8154.347652187811;8172.305354044914;8187.549684767336;8229.711960081399;2224.377174391173;2241.2267767620147;2255.0979608156704;2258.0403328585367;2264.230161745006;2333.626619740833;2349.3186975777003;2349.788519033287;2357.5284943011466;2384.821138414617;2265.660150977358;2308.9538209235807;2313.375388645065;2335.241046659842;2357.95284094318;2293.323469576479;2315.22439982606;2322.140807901079;2335.7897789198882;2339.4736184358553;2375.6080246759266;2385.9284221473386;2386.4869053153484;2397.496525729599;2401.543706695722;7974.082980457264;8021.558814265213;8022.237887400687;8034.839303213961;8036.4776289541;4685.789139488731;4784.856454306341;4820.879478013043;4829.782659780319;4830.275458681191;2982.3140677644046;3007.7593792496546;3032;3044.0867739678006;3062.969370306291;949.0746522140857;963.7879666473365;971.621067783565;972.8200282947678;983.1544871410653;10941.945290273577;11034.006939375495;11040.723981900355;11048.889511104946;11048.944755276252;4141.710080294411;4182.309918863414;4196.223698615766;4217.873463796091;4222.261104306734;8910.821783564292;9014.504202268807;9019.413738107001;9022.86465703015;9034.23209027227;4732.408448943882;4741.1465936131135;4756.738379389167;4757.833475828329;4759.309900064472;4353.325234588644;4360.215161271001;4362.716423432466;4390.604845563915;4392.165488557228;3431.039308993486;3444.9655503445147;3461.7057550108525;3464.965350346464;3499.2476617527354;1021.7190272675074;1046.7801761629992;1060.5068643081004;1064.744461329291;1066.461436974323;964.6479035152119;1112.7941330853819;1130.9321440713584;1299.1815156451564;1410.2173293821822;7174.461915356369;7218.8917166242545;7226.168990566152;7262.673179706926;7301.744438944612;642.325558163926;657.1555551116792;659.4954859532462;667.0328024364691;794.0693566844145;5320.494553017457;5399.83800485986;5418.160185171305;5422.539084177889;5428.240046393508;9190.03504632004;9226.630934762668;9491.905080949102;9602.423854568748;9705.5147242639;9458.101480359355;9464;9529.952350238344;9544.95227523858;9565.091316324939;7486.5508069516;7550.093988721389;7550.509216900884;7553.924460755432;7615.5430674159725;7099.680514376762;7101.609411482418;7121.038659780863;7122.715091396286;7169.4981351304905;8324.875126872981;8537.615807288563;8555.401121921655;8595.613197406257;8714.738557843275;8677.739667809976;8785;8787.34094942869;8791.120887911158;8911.108889111038;6712.060311556288;6880.277570854988;7318.3047610476915;7318.634068296457;7334.083239595051;7564.735234266775;7607.657655405409;7629.618519074135;7636.12184598756;7676.193999629959;6815.727370905108;7073.893891591527;7236.4210863131875;7282.162551306667;7313.853722925618;7065.788026359218;7098.609576473344;7119.857602848017;7176.138863336433;7236.131664200329;7284.125904891447;7294.161171465349;7316.487845850952;7317.085364329459;7331.340179383881;6365.522585806176;6380.808575742735;6399.488040956619;6415.743370265323;6438.806835794933;6205.751769929152;6315.147455093504;6346.048092786119;6349;6351.174347335002 14:58:49 INFO - 2016-01-04 14:58:49,390 DEBUG : BROWSER_OUTPUT: |4;prototype.html;362.67540551206673;368.6810908564093;369.6248307967414;370.4480324316767;375.363758429462;6251.874962500748;6309.558330916838;6358.45953093987;6379.9681001595045;6381.266154392246;6159.8768024639485;6270.874582508359;6271.404216599416;6292.528060395466;6295.653739044351;4831.347768051312;4840.128776820171;4848.054629347279;4854.587360074398;4856.975715121437;4864.902701945959;4872.7563621818945;4886.267059941019;4890.486498917616;4901.313816065754;4760.952390476103;4849.224124140138;4866.148424025799;4883.023395320933;4884.462709101996;4850.563449289563;4854.87862803431;4861.586765124968;4870.074685809703;4872.56146946773;4291.871243862689;4305.913881722348;4308.6983911126235;4310.719803212813;4323.675724320657;5888.941110588882;6006.279246490405;6010.459058684695;6011.5190784737115;6021.09683547467;5683.886322273573;5687.118496633028;5688.573356998241;5689.975804355215;5698.6865722385255;6643.701033453458;6650.068990341356;6663;6665.866682666368;6667.499937504706;4756.7145971241835;4770.189067858472;4781.569658730697;4788.209945359012;4793.113274044278;6755.898661520081;6868.141482314661;6915.757948471779;6917.169939607279;6925.065116209297;4877.414710234794;4879.2925025871045;4889.975550122226;4896.608271338285;4911.214205727067;4946.455889852114;4954.578860796801;4955.529224723646;4958.157113290677;4964.553190212898;5543.223948647193;5653.802116925888;5655.236543066716;5670.206171136044;5674.2339784129435;6695;6704.396604305538;6714.52998290115;6714.731410743613;6749.257581666013;1678.4796713019002;1722.7329763886617;1727.6976529107355;1732.618823858749;1741.3469948769211;1148.8219326004482;1165.452237448398;1171.9335404781607;1173.342927960345;1184.6505280942142;6486.513511486657;6524.804255872332;6525.673716314165;6530.216374035146;6555.115059466911;6899.931000689929;6903.378695917391;6904.206016308089;6907.378335949788;6914.827129321707;6409.442759268558;6487.643179625166;6533.542652014314;6544.640044797582;6546.5744726593575;3718.9442158367647;3744.063984003999;3746.0447585865977;3748.9877733011936;3749.0439937816227;7123.501354905107;7132.500724949204;7141.178764442052;7146.964265178744;7170.4622153338705;6886.724531018804;6992.230854605989;6997;7026.578405295699;7062.788116356517;7141.785746427511;7143.714251429885;7145.356917877416;7145.785626431215;7146.3568278855155;6849.452043836581;6889.207741109636;6902.102726645504;6909.170899491892;6919;6641.900371494528;6793.966030169818;6800.047993280846;6807.9319206807295;6828.863422731418;7049.823754405976;7113.857722845618;7119.2168861426235;7124.430045596237;7130.322619351154;4786.2342025277185;4801.567858892717;4806.47128815837;4810.831620893252;4819.084373968934;6794.72821087151;6869.656517174221;6886.586804791728;6886.965565172142;6899.310068993061;6622.304658011032;6657.267700553032;6659.367360100783;6662.6335551545135;6682.264950855305;6636.369544893228;6655.267920528835;6655.833604159935;6657.06801047844;6665.3001434850585;6461.579997300349;6518.902216466851;6559.147310849559;6561.540692151503;6564.770233041821;6656.23453302857;6656.567323123982;6660.700268487833;6693.933060669331;6697.598144111369;6485.383888530582;6496.563788579283;6535.901961470487;6540.574862633914;6549.377809108127 14:58:49 INFO - 2016-01-04 14:58:49,391 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.7709532949452;744.2520267131532;746.0487877955609;861.655337864854;906.8186362727452;13166.407511661975;13230.073894827354;13262.867371326283;13285.601431957033;13362.866371336284;13493.6506349365;13495;13644.590662280123;13663.590092297221;13672.111312764688;899.1008991009007;911.8723378726984;925.5464822237122;931.4923366765096;933.6032186320821;903.7288813356;911.5305617606938;915.1351972386097;915.4049867586056;916.138829500271;966.6278482784144;976.9120779129877;980.691082309074;982.5087456271864;982.6609819612222;971.5142428785607;977.5258999385293;977.6236149082583;978.0757184460688;978.3640633588153;711.1430725975239;712.597382478903;712.8645557344088;714.103799731339;716.451914285572;14445.133292002514;14492;14497.130172189702;14525.491607793676;14538.273086345745;12241.632751017483;12672.303023333712;13059.934700326532;13139.211647301097;13313.600591982256;10918.945405272923;11054.723631909186;11322.94338528302;11726.413679316085;11759.941200293944;3628.2199327144526;3653.178034942117;3754.607109681679;3798.582155962842;3811.7712937223855;48164.518354816704;48193.99999999965;48357;48672;48676.26985595219;9347;9580.18568421678;9819.950900245452;9948.701538953843;10183.18534517237;19072.14175362112;19170;19211.135498902582;19236.71144932827;19273.903630482037;7890.723824666109;7917.445778795429;8009.559474228973;8020.318272946748;8202.343812494986;4402.3836662867225;4623.468301145344;4684.227102528044;4738.170820106537;4768.998510312804;3085.768567357457;3113.2839446927333;3131.9686803131676;3135.1848519385126;3143.449896268144;584.9181114643953;593.0896074525582;599.6162456028145;600.2287061126519;602.1569802276847;581.4214856218006;586.8521212362817;662.8259309464962;718.60476737794;731.5537522111508;8841.115888411236;9088.727338179866;9203.723888283363;9209.907900921038;9214.401063930824;509.4090854608636;611;648.1088503307951;689.7378995981495;730.7990302666809;4211.768352740629;4281.678874084456;4383.101464199832;4415.381846541487;4532.637389008872;58689;58837;59388;60027.699861501285;60107.699461502416;53843;54415.45584544183;54684.453155467934;55099;55376.44623553794;48047.519524805;48604.75697621489;48656.27015594769;48861.755691222024;48944.26583601249;8658.350623703122;8770.561471926505;8959.283257339266;9031.277497800029;9133.543322833964;35419.29161416809;36205.637943620226;36278.637213627524;36542.45186322154;36860.447093294155;40728.389074163315;46185.538144619466;46258.30612540882;47521.52478475171;47522.04955900932;11190.104791616814;11246.775064498828;11277.32336059839;11284.32294062359;11488.48301826403;11354.772904542027;11495.252808567417;11570.94214528922;11865.288082715064;12104.092193085378;10665.253432259979;10941.398223097487;11279.09767218604;12960.740785184054;13100.410481528545;11921.165518413974;12112.21270617407;12311.753764924471;12404.25574465535;13164.275964822027;10471.94764026175;12067.57763478274;12860.485580576673;12943.09398342107;13353.866461335263;10182.541785619813;10349.689509314732;10435.582576696846;10601.151907847508;10949.397783122005;10236.846447303147;10379.325343852626;10510.527026283988;10516.631917882838;10682.8397574038 14:58:49 INFO - 2016-01-04 14:58:49,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:58:49 INFO - 2016-01-04 14:58:49,391 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:58:49 INFO - 2016-01-04 14:58:49,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,294 14:58:49 INFO - 2016-01-04 14:58:49,393 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:58:49 INFO - 2016-01-04 14:58:49,393 DEBUG : BROWSER_OUTPUT: __startTimestamp1451948329379__endTimestamp 14:58:49 INFO - 2016-01-04 14:58:49,393 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,394 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:58:49 INFO - 2016-01-04 14:58:49,394 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:58:49 INFO - 2016-01-04 14:58:49,394 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,394 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5535.92 Median:5718.09 stddev:622.85 (10.9%) stddev-sans-first:599.18 14:58:49 INFO - 2016-01-04 14:58:49,395 DEBUG : BROWSER_OUTPUT: Values: 3283.7 3287.5 3306.4 3328.7 3350.4 5385.6 5420.3 5421.2 5428.8 5467.0 5424.9 5458.7 5459.0 5464.4 5475.9 4969.0 4998.8 5031.5 5041.7 5071.7 4946.0 5041.8 5101.6 5104.3 5107.9 5047.1 5059.9 5129.9 5135.5 5152.5 5091.1 5172.0 5179.1 5179.6 5205.8 4797.3 4920.4 5025.5 5076.2 5077.3 5349.3 5425.2 5426.1 5443.1 5471.3 6012.4 6042.2 6094.5 6098.7 6107.9 5769.9 5921.1 6004.2 6053.8 6114.2 5613.7 5682.5 5688.5 5697.8 5708.2 6101.5 6138.5 6153.2 6154.9 6167.4 5784.6 5906.5 5908.6 5910.7 5915.5 5712.3 5796.5 5990.0 6123.4 6129.3 5859.0 5885.1 5890.5 5905.3 5906.8 5705.7 5918.1 5931.6 5941.6 5955.1 4514.2 4566.0 4572.4 4596.1 4604.4 4097.0 4112.6 4119.6 4147.8 4169.8 5506.9 5623.8 5703.2 5717.5 5718.1 5986.1 6057.3 6128.1 6130.6 6131.0 5539.3 5588.1 5590.6 5598.1 5607.8 5056.0 5087.1 5135.0 5155.3 5167.6 5946.2 6066.6 6101.9 6106.4 6106.7 5864.5 5907.2 5919.0 5930.0 5931.5 6067.2 6082.0 6088.8 6098.1 6205.9 6003.8 6037.0 6044.8 6058.5 6060.4 6097.7 6129.6 6130.4 6136.8 6146.1 5656.3 5737.9 5745.6 5863.1 5965.1 5726.0 5907.9 5916.4 5921.6 5922.7 5749.1 5821.1 5822.0 5831.7 5840.4 5526.4 5543.2 5655.1 5704.9 5724.7 5508.0 5733.9 5814.6 5826.6 5827.1 14:58:49 INFO - 2016-01-04 14:58:49,395 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,395 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59836.47 Median:209487.63 stddev:131802.46 (62.9%) stddev-sans-first:132097.22 14:58:49 INFO - 2016-01-04 14:58:49,396 DEBUG : BROWSER_OUTPUT: Values: 622.7 628.2 667.5 668.7 687.2 40458.6 41583.0 41915.8 41930.0 42073.2 44997.8 45717.0 45828.8 45871.3 45906.5 8673.9 8773.2 8817.7 8857.2 8865.7 8558.5 8620.7 8651.5 8710.9 8722.5 8664.7 8745.4 8754.0 8769.6 8812.7 8600.6 8641.4 8675.4 8678.9 8700.3 8537.3 8632.6 8646.4 8682.1 8691.4 42940.4 43227.9 43307.6 43348.3 43511.3 3418.3 3427.1 3459.7 3516.4 4184.2 31655.7 32077.5 32360.4 32606.0 32849.0 3947.8 4021.4 4061.8 4086.2 4126.3 291852.0 292112.0 292362.0 293385.0 296324.0 43978.6 44321.3 64946.0 65155.7 65344.7 42447.8 42699.8 42720.8 42962.8 42968.1 14905.7 15006.8 15037.7 15079.6 15101.0 11598.4 11610.2 11622.1 11638.2 11681.1 14786.6 15440.7 15453.2 15490.4 15529.8 6117.1 6259.3 6328.6 6359.4 6372.7 1011.8 1042.9 1052.1 1054.0 1085.8 28603.3 28614.6 28824.3 29063.6 29296.9 1115.7 1131.8 1174.0 1230.7 1250.9 17128.0 17892.0 17905.6 18160.3 18189.6 414849.0 760320.0 788343.0 794940.0 805686.0 59142.7 60162.7 60304.0 60498.0 60536.1 1457.8 1491.2 1493.3 1495.7 1506.4 30089.4 30390.8 30478.5 31362.7 31628.0 46882.0 47120.5 47382.3 47500.5 47570.8 317707.0 319363.0 319441.0 320483.0 320797.0 34157.0 48609.0 48781.8 48974.0 49486.5 44489.0 45110.8 45674.5 45927.5 45928.3 37950.2 38613.6 39023.2 39218.2 39715.8 38959.4 39181.8 39781.4 39812.0 39887.4 44019.1 44201.0 44264.0 45135.3 45513.5 33689.7 33768.0 34214.3 34223.7 34659.7 26665.1 27669.0 28326.0 30352.0 31158.7 14:58:49 INFO - 2016-01-04 14:58:49,397 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,397 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30693.54 Median:1942.82 stddev:97524.17 (5019.7%) stddev-sans-first:97771.22 14:58:49 INFO - 2016-01-04 14:58:49,398 DEBUG : BROWSER_OUTPUT: Values: 394.5 395.4 397.5 398.3 399.0 15013.8 16186.0 16727.0 17314.7 17351.3 11788.2 12149.3 12153.9 17110.1 18454.8 5011.9 5096.8 5112.4 5116.8 5321.9 5323.0 5418.1 5454.0 5476.9 5477.5 5396.3 5446.6 5457.2 5856.8 6114.1 6174.6 6176.2 6177.7 6178.7 6180.1 5215.0 5340.4 5350.4 5502.0 5515.4 13321.9 13413.7 13465.7 17863.4 20485.9 1954.9 2024.4 2043.6 2054.6 2161.1 9693.8 9840.3 10100.5 10110.3 10180.4 1852.7 1884.9 1910.9 1927.6 1930.7 61248.7 62715.7 63532.0 63825.0 65091.7 10970.1 10986.1 11004.6 11113.9 11115.4 14247.4 14253.8 14315.2 14330.1 14358.9 8115.9 8128.3 8169.0 8182.6 8188.8 7815.7 7830.1 7848.9 7875.6 7879.3 4618.4 4752.6 4763.4 4842.0 4862.8 1904.1 1957.4 1986.0 2008.5 2014.2 898.0 996.7 1059.9 1067.7 1113.2 17080.3 17754.5 18018.7 18103.3 18268.6 967.0 972.9 1032.4 1056.6 1059.4 10102.7 10423.9 10434.3 10510.9 10575.3 483437.0 619627.0 621294.0 622926.0 624927.0 82545.2 82620.0 82939.6 84440.2 84559.6 1173.4 1195.3 1207.3 1210.8 1227.3 16625.0 16793.7 16866.6 17012.7 17081.6 33023.2 33104.0 33165.8 34854.1 37576.2 43905.0 46255.0 47290.5 47347.8 49676.3 9892.0 10100.4 10611.0 10645.0 10656.9 17733.1 17781.5 17994.9 18199.8 18583.9 13214.2 13663.2 13752.3 14683.7 14933.0 14717.6 14798.8 14987.3 15019.1 15383.1 15238.1 15280.1 15289.8 15578.1 15625.2 9765.3 9908.6 10106.0 10191.7 10201.5 10826.8 14623.9 15536.0 15787.4 15927.3 14:58:49 INFO - 2016-01-04 14:58:49,399 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,399 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5518.11 Median:658.33 stddev:2909.49 (442.0%) stddev-sans-first:2902.28 14:58:49 INFO - 2016-01-04 14:58:49,400 DEBUG : BROWSER_OUTPUT: Values: 1538.0 1577.2 1613.4 1804.2 1877.2 7915.4 7955.8 7973.4 8111.5 8135.8 8057.5 8154.3 8172.3 8187.5 8229.7 2224.4 2241.2 2255.1 2258.0 2264.2 2333.6 2349.3 2349.8 2357.5 2384.8 2265.7 2309.0 2313.4 2335.2 2358.0 2293.3 2315.2 2322.1 2335.8 2339.5 2375.6 2385.9 2386.5 2397.5 2401.5 7974.1 8021.6 8022.2 8034.8 8036.5 4685.8 4784.9 4820.9 4829.8 4830.3 2982.3 3007.8 3032.0 3044.1 3063.0 949.1 963.8 971.6 972.8 983.2 10941.9 11034.0 11040.7 11048.9 11048.9 4141.7 4182.3 4196.2 4217.9 4222.3 8910.8 9014.5 9019.4 9022.9 9034.2 4732.4 4741.1 4756.7 4757.8 4759.3 4353.3 4360.2 4362.7 4390.6 4392.2 3431.0 3445.0 3461.7 3465.0 3499.2 1021.7 1046.8 1060.5 1064.7 1066.5 964.6 1112.8 1130.9 1299.2 1410.2 7174.5 7218.9 7226.2 7262.7 7301.7 642.3 657.2 659.5 667.0 794.1 5320.5 5399.8 5418.2 5422.5 5428.2 9190.0 9226.6 9491.9 9602.4 9705.5 9458.1 9464.0 9530.0 9545.0 9565.1 7486.6 7550.1 7550.5 7553.9 7615.5 7099.7 7101.6 7121.0 7122.7 7169.5 8324.9 8537.6 8555.4 8595.6 8714.7 8677.7 8785.0 8787.3 8791.1 8911.1 6712.1 6880.3 7318.3 7318.6 7334.1 7564.7 7607.7 7629.6 7636.1 7676.2 6815.7 7073.9 7236.4 7282.2 7313.9 7065.8 7098.6 7119.9 7176.1 7236.1 7284.1 7294.2 7316.5 7317.1 7331.3 6365.5 6380.8 6399.5 6415.7 6438.8 6205.8 6315.1 6346.0 6349.0 6351.2 14:58:49 INFO - 2016-01-04 14:58:49,401 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,401 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5617.67 Median:6435.51 stddev:1661.71 (25.8%) stddev-sans-first:1618.88 14:58:49 INFO - 2016-01-04 14:58:49,401 DEBUG : BROWSER_OUTPUT: Values: 362.7 368.7 369.6 370.4 375.4 6251.9 6309.6 6358.5 6380.0 6381.3 6159.9 6270.9 6271.4 6292.5 6295.7 4831.3 4840.1 4848.1 4854.6 4857.0 4864.9 4872.8 4886.3 4890.5 4901.3 4761.0 4849.2 4866.1 4883.0 4884.5 4850.6 4854.9 4861.6 4870.1 4872.6 4291.9 4305.9 4308.7 4310.7 4323.7 5888.9 6006.3 6010.5 6011.5 6021.1 5683.9 5687.1 5688.6 5690.0 5698.7 6643.7 6650.1 6663.0 6665.9 6667.5 4756.7 4770.2 4781.6 4788.2 4793.1 6755.9 6868.1 6915.8 6917.2 6925.1 4877.4 4879.3 4890.0 4896.6 4911.2 4946.5 4954.6 4955.5 4958.2 4964.6 5543.2 5653.8 5655.2 5670.2 5674.2 6695.0 6704.4 6714.5 6714.7 6749.3 1678.5 1722.7 1727.7 1732.6 1741.3 1148.8 1165.5 1171.9 1173.3 1184.7 6486.5 6524.8 6525.7 6530.2 6555.1 6899.9 6903.4 6904.2 6907.4 6914.8 6409.4 6487.6 6533.5 6544.6 6546.6 3718.9 3744.1 3746.0 3749.0 3749.0 7123.5 7132.5 7141.2 7147.0 7170.5 6886.7 6992.2 6997.0 7026.6 7062.8 7141.8 7143.7 7145.4 7145.8 7146.4 6849.5 6889.2 6902.1 6909.2 6919.0 6641.9 6794.0 6800.0 6807.9 6828.9 7049.8 7113.9 7119.2 7124.4 7130.3 4786.2 4801.6 4806.5 4810.8 4819.1 6794.7 6869.7 6886.6 6887.0 6899.3 6622.3 6657.3 6659.4 6662.6 6682.3 6636.4 6655.3 6655.8 6657.1 6665.3 6461.6 6518.9 6559.1 6561.5 6564.8 6656.2 6656.6 6660.7 6693.9 6697.6 6485.4 6496.6 6535.9 6540.6 6549.4 14:58:49 INFO - 2016-01-04 14:58:49,401 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2016-01-04 14:58:49,402 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14364.74 Median:25471.27 stddev:16513.83 (64.8%) stddev-sans-first:16528.35 14:58:49 INFO - 2016-01-04 14:58:49,403 DEBUG : BROWSER_OUTPUT: Values: 715.8 744.3 746.0 861.7 906.8 13166.4 13230.1 13262.9 13285.6 13362.9 13493.7 13495.0 13644.6 13663.6 13672.1 899.1 911.9 925.5 931.5 933.6 903.7 911.5 915.1 915.4 916.1 966.6 976.9 980.7 982.5 982.7 971.5 977.5 977.6 978.1 978.4 711.1 712.6 712.9 714.1 716.5 14445.1 14492.0 14497.1 14525.5 14538.3 12241.6 12672.3 13059.9 13139.2 13313.6 10918.9 11054.7 11322.9 11726.4 11759.9 3628.2 3653.2 3754.6 3798.6 3811.8 48164.5 48194.0 48357.0 48672.0 48676.3 9347.0 9580.2 9820.0 9948.7 10183.2 19072.1 19170.0 19211.1 19236.7 19273.9 7890.7 7917.4 8009.6 8020.3 8202.3 4402.4 4623.5 4684.2 4738.2 4769.0 3085.8 3113.3 3132.0 3135.2 3143.4 584.9 593.1 599.6 600.2 602.2 581.4 586.9 662.8 718.6 731.6 8841.1 9088.7 9203.7 9209.9 9214.4 509.4 611.0 648.1 689.7 730.8 4211.8 4281.7 4383.1 4415.4 4532.6 58689.0 58837.0 59388.0 60027.7 60107.7 53843.0 54415.5 54684.5 55099.0 55376.4 48047.5 48604.8 48656.3 48861.8 48944.3 8658.4 8770.6 8959.3 9031.3 9133.5 35419.3 36205.6 36278.6 36542.5 36860.4 40728.4 46185.5 46258.3 47521.5 47522.0 11190.1 11246.8 11277.3 11284.3 11488.5 11354.8 11495.3 11570.9 11865.3 12104.1 10665.3 10941.4 11279.1 12960.7 13100.4 11921.2 12112.2 12311.8 12404.3 13164.3 10471.9 12067.6 12860.5 12943.1 13353.9 10182.5 10349.7 10435.6 10601.2 10949.4 10236.8 10379.3 10510.5 10516.6 10682.8 14:58:49 INFO - 2016-01-04 14:58:49,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:58:49 INFO - 2016-01-04 14:58:49,403 DEBUG : BROWSER_OUTPUT: 14:58:50 INFO - 2016-01-04 14:58:50,058 INFO : Browser exited with error code: 0 14:58:50 INFO - 2016-01-04 14:58:50,074 INFO : Completed test dromaeo_css (00:18:27) 14:58:50 INFO - 2016-01-04 14:58:50,074 INFO : Starting test kraken 14:58:50 INFO - 2016-01-04 14:58:50,074 DEBUG : operating with platform_type : linux_ 14:58:50 INFO - 2016-01-04 14:58:50,074 INFO : Initialising browser for kraken test... 14:58:50 INFO - 2016-01-04 14:58:50,080 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy788Qu/profile http://localhost:50798/getInfo.html 14:58:54 INFO - 2016-01-04 14:58:54,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:58:54 INFO - 2016-01-04 14:58:54,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:58:54 INFO - 2016-01-04 14:58:54,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:58:54 INFO - 2016-01-04 14:58:54,293 DEBUG : BROWSER_OUTPUT: __metrics 14:58:55 INFO - 2016-01-04 14:58:55,273 INFO : Browser initialized. 14:58:55 INFO - 2016-01-04 14:58:55,274 INFO : Running cycle 1/1 for kraken test... 14:58:55 INFO - 2016-01-04 14:58:55,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy788Qu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:59:07 INFO - 2016-01-04 14:59:07,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 136953856 14:59:07 INFO - 2016-01-04 14:59:07,122 DEBUG : BROWSER_OUTPUT: 14:59:09 INFO - 2016-01-04 14:59:09,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50798/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:10 INFO - 2016-01-04 14:59:10,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 138911744 14:59:10 INFO - 2016-01-04 14:59:10,184 DEBUG : BROWSER_OUTPUT: 14:59:12 INFO - 2016-01-04 14:59:12,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50798/tests/kraken/driver.html?testName=audio-dft) 14:59:13 INFO - 2016-01-04 14:59:13,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 139595776 14:59:13 INFO - 2016-01-04 14:59:13,372 DEBUG : BROWSER_OUTPUT: 14:59:16 INFO - 2016-01-04 14:59:16,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50798/tests/kraken/driver.html?testName=audio-fft) 14:59:16 INFO - 2016-01-04 14:59:16,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 138792960 14:59:16 INFO - 2016-01-04 14:59:16,769 DEBUG : BROWSER_OUTPUT: 14:59:18 INFO - 2016-01-04 14:59:18,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50798/tests/kraken/driver.html?testName=audio-oscillator) 14:59:19 INFO - 2016-01-04 14:59:19,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 14:59:19 INFO - 2016-01-04 14:59:19,370 DEBUG : BROWSER_OUTPUT: 14:59:21 INFO - 2016-01-04 14:59:21,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:22 INFO - 2016-01-04 14:59:22,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 139620352 14:59:22 INFO - 2016-01-04 14:59:22,150 DEBUG : BROWSER_OUTPUT: 14:59:25 INFO - 2016-01-04 14:59:25,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50798/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:25 INFO - 2016-01-04 14:59:25,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 14:59:25 INFO - 2016-01-04 14:59:25,688 DEBUG : BROWSER_OUTPUT: 14:59:29 INFO - 2016-01-04 14:59:29,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50798/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:29 INFO - 2016-01-04 14:59:29,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 140005376 14:59:29 INFO - 2016-01-04 14:59:29,636 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2016-01-04 14:59:32,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50798/tests/kraken/driver.html?testName=json-parse-financial) 14:59:32 INFO - 2016-01-04 14:59:32,986 DEBUG : BROWSER_OUTPUT: RSS: Main: 138145792 14:59:32 INFO - 2016-01-04 14:59:32,987 DEBUG : BROWSER_OUTPUT: 14:59:34 INFO - 2016-01-04 14:59:34,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:35 INFO - 2016-01-04 14:59:35,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 138293248 14:59:35 INFO - 2016-01-04 14:59:35,144 DEBUG : BROWSER_OUTPUT: 14:59:36 INFO - 2016-01-04 14:59:36,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:37 INFO - 2016-01-04 14:59:37,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 138248192 14:59:37 INFO - 2016-01-04 14:59:37,511 DEBUG : BROWSER_OUTPUT: 14:59:39 INFO - 2016-01-04 14:59:39,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:40 INFO - 2016-01-04 14:59:40,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 139227136 14:59:40 INFO - 2016-01-04 14:59:40,118 DEBUG : BROWSER_OUTPUT: 14:59:42 INFO - 2016-01-04 14:59:42,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:43 INFO - 2016-01-04 14:59:43,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 14:59:43 INFO - 2016-01-04 14:59:43,078 DEBUG : BROWSER_OUTPUT: 14:59:45 INFO - 2016-01-04 14:59:45,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:46 INFO - 2016-01-04 14:59:46,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 139104256 14:59:46 INFO - 2016-01-04 14:59:46,198 DEBUG : BROWSER_OUTPUT: 14:59:47 INFO - 2016-01-04 14:59:47,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50798/tests/kraken/driver.html?testName=ai-astar) 14:59:48 INFO - 2016-01-04 14:59:48,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 139522048 14:59:48 INFO - 2016-01-04 14:59:48,103 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,104 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:59:48 INFO - 2016-01-04 14:59:48,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:59:48 INFO - 2016-01-04 14:59:48,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:59:48 INFO - 2016-01-04 14:59:48,104 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:59:48 INFO - 2016-01-04 14:59:48,104 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;103;112;112;111;122;111;111;111;110 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;148;160;121;154;147;123;164;125 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;165;167;160;159;162;162;162 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;72;164;73;70;70;70;161;70 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;95;142;93;92;93;137;94;93;136 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;111;109;109;110;110;110;110;110 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;145;147;146;146;145;147;147 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;96;97;95;96;96 14:59:48 INFO - 2016-01-04 14:59:48,105 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;64;62;63;65;63;65;59;62 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;64;64;64;63;64;64;64 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;79;80;80;90;88;81;84;81;82 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;113;113;115;120;114;122;123;114;118 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;144;146;148;145;149;146;149;153 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;64;66;65;64;68;65;64;66 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:59:48 INFO - 2016-01-04 14:59:48,106 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:59:48 INFO - 2016-01-04 14:59:48,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,735 14:59:48 INFO - 2016-01-04 14:59:48,107 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:59:48 INFO - 2016-01-04 14:59:48,107 DEBUG : BROWSER_OUTPUT: __startTimestamp1451948388103__endTimestamp 14:59:48 INFO - 2016-01-04 14:59:48,107 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,110 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:59:48 INFO - 2016-01-04 14:59:48,110 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:4.55 (4.1%) stddev-sans-first:4.82 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: Values: 112.0 103.0 112.0 112.0 111.0 122.0 111.0 111.0 111.0 110.0 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:151.00 stddev:17.07 (11.3%) stddev-sans-first:17.36 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 148.0 160.0 121.0 154.0 147.0 123.0 164.0 125.0 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.33 (1.4%) stddev-sans-first:2.44 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 165.0 167.0 160.0 159.0 162.0 162.0 162.0 14:59:48 INFO - 2016-01-04 14:59:48,111 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.10 Median:71.00 stddev:38.24 (53.9%) stddev-sans-first:40.31 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 72.0 164.0 73.0 70.0 70.0 70.0 161.0 70.0 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:21.90 (23.5%) stddev-sans-first:22.57 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: Values: 92.0 95.0 142.0 93.0 92.0 93.0 137.0 94.0 93.0 136.0 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 111.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 14:59:48 INFO - 2016-01-04 14:59:48,112 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 145.0 147.0 146.0 146.0 145.0 147.0 147.0 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 14:59:48 INFO - 2016-01-04 14:59:48,113 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.73 (2.7%) stddev-sans-first:1.83 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 62.0 63.0 65.0 63.0 65.0 59.0 62.0 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 64.0 14:59:48 INFO - 2016-01-04 14:59:48,114 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.50 stddev:3.92 (4.8%) stddev-sans-first:3.83 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: Values: 78.0 79.0 80.0 80.0 90.0 88.0 81.0 84.0 81.0 82.0 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:116.50 stddev:4.16 (3.6%) stddev-sans-first:3.95 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 113.0 115.0 120.0 114.0 122.0 123.0 114.0 118.0 14:59:48 INFO - 2016-01-04 14:59:48,115 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:147.00 stddev:3.92 (2.7%) stddev-sans-first:2.74 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 144.0 146.0 148.0 145.0 149.0 146.0 149.0 153.0 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 64.0 66.0 65.0 64.0 68.0 65.0 64.0 66.0 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:59:48 INFO - 2016-01-04 14:59:48,116 DEBUG : BROWSER_OUTPUT: 14:59:48 INFO - 2016-01-04 14:59:48,966 INFO : Browser exited with error code: 0 14:59:49 INFO - 2016-01-04 14:59:49,014 INFO : Completed test kraken (00:00:58) 14:59:49 INFO - 2016-01-04 14:59:49,014 INFO : Starting test v8_7 14:59:49 INFO - 2016-01-04 14:59:49,014 DEBUG : operating with platform_type : linux_ 14:59:49 INFO - 2016-01-04 14:59:49,014 INFO : Initialising browser for v8_7 test... 14:59:49 INFO - 2016-01-04 14:59:49,020 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX4s8rF/profile http://localhost:50798/getInfo.html 14:59:53 INFO - 2016-01-04 14:59:53,108 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:59:53 INFO - 2016-01-04 14:59:53,108 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:59:53 INFO - 2016-01-04 14:59:53,108 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:59:53 INFO - 2016-01-04 14:59:53,108 DEBUG : BROWSER_OUTPUT: __metrics 14:59:54 INFO - 2016-01-04 14:59:54,069 INFO : Browser initialized. 14:59:54 INFO - 2016-01-04 14:59:54,070 INFO : Running cycle 1/1 for v8_7 test... 14:59:54 INFO - 2016-01-04 14:59:54,070 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX4s8rF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:00:05 INFO - 2016-01-04 15:00:05,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 136327168 15:00:05 INFO - 2016-01-04 15:00:05,867 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50798/tests/v8_7/run.html (next: http://localhost:50798/tests/v8_7/run.html) 15:00:27 INFO - 2016-01-04 15:00:27,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 135839744 15:00:27 INFO - 2016-01-04 15:00:27,540 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,540 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:00:27 INFO - 2016-01-04 15:00:27,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: |0;Richards;167.11229946524065 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.26194017517767 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8199943836001 15:00:27 INFO - 2016-01-04 15:00:27,541 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |4;RayTrace;916.5902841429881 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |5;Earley;544.6623093681917 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |6;Boyer;10755.31914893617 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |7;RegExp;24463.414634146342 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |8;Splay;515.4639175257732 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: __startTimestamp1451948427537__endTimestamp 15:00:27 INFO - 2016-01-04 15:00:27,542 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.11 Median:167.11 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: Values: 167.1 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,543 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.26 Median:165.26 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,544 DEBUG : BROWSER_OUTPUT: Values: 165.3 15:00:27 INFO - 2016-01-04 15:00:27,544 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,544 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,544 DEBUG : BROWSER_OUTPUT: Values: 280.8 15:00:27 INFO - 2016-01-04 15:00:27,544 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: Values: 5229.2 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:916.59 Median:916.59 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: Values: 916.6 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.66 Median:544.66 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: Values: 544.7 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,545 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10755.32 Median:10755.32 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: Values: 10755.3 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24463.41 Median:24463.41 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: Values: 24463.4 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:515.46 Median:515.46 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,546 DEBUG : BROWSER_OUTPUT: Values: 515.5 15:00:27 INFO - 2016-01-04 15:00:27,547 DEBUG : BROWSER_OUTPUT: 15:00:27 INFO - 2016-01-04 15:00:27,547 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 15:00:27 INFO - 2016-01-04 15:00:27,547 DEBUG : BROWSER_OUTPUT: Values: 4826.9 15:00:27 INFO - 2016-01-04 15:00:27,547 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:00:27 INFO - 2016-01-04 15:00:27,547 DEBUG : BROWSER_OUTPUT: 15:00:28 INFO - 2016-01-04 15:00:28,366 INFO : Browser exited with error code: 0 15:00:28 INFO - 2016-01-04 15:00:28,382 INFO : Completed test v8_7 (00:00:39) 15:00:28 INFO - 2016-01-04 15:00:28,598 INFO : Completed test suite (00:20:06) 15:00:28 INFO - 2016-01-04 15:00:28,598 DEBUG : Working with test: dromaeo_css 15:00:28 INFO - 2016-01-04 15:00:28,598 DEBUG : Generating results file: dromaeo_css 15:00:28 INFO - 2016-01-04 15:00:28,599 DEBUG : Working with test: kraken 15:00:28 INFO - 2016-01-04 15:00:28,600 DEBUG : Generating results file: kraken 15:00:28 INFO - 2016-01-04 15:00:28,600 INFO : javascript benchmark 15:00:28 INFO - 2016-01-04 15:00:28,600 DEBUG : Working with test: v8_7 15:00:28 INFO - 2016-01-04 15:00:28,600 DEBUG : Generating results file: v8_7 15:00:28 INFO - 2016-01-04 15:00:28,601 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:28 INFO - 2016-01-04 15:00:28,739 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 15:00:28 INFO - 2016-01-04 15:00:28,739 DEBUG : process_Request line: dromaeo_css 7293.24 graph.html#tests=[[72,52,43]] 15:00:28 INFO - 2016-01-04 15:00:28,739 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:28 INFO - 2016-01-04 15:00:28,847 DEBUG : process_Request line: kraken 1501.80 graph.html#tests=[[232,52,43]] 15:00:28 INFO - 2016-01-04 15:00:28,847 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:00:28 INFO - 2016-01-04 15:00:28,965 DEBUG : process_Request line: v8_7 23291.05 graph.html#tests=[[230,52,43]] 15:00:28 INFO - 2016-01-04 15:00:28,966 INFO : javascript benchmark 15:00:29 INFO - 2016-01-04 15:00:28,969 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3283.7044665980056, 3287.5233091201776, 3306.404847127516, 3328.6671332866717, 3350.363430948119, 5385.5960802939835, 5420.349558053034, 5421.186821976706, 5428.805662754193, 5467.015937131315, 5424.945750542493, 5458.6724796512135, 5458.972705136479, 5464.371597266306, 5475.863103422416, 4969.031038947407, 4998.775055122519, 5031.547160755531, 5041.72270525121, 5071.670341427814, 4945.975270123644, 5041.773120209581, 5101.591872650198, 5104.259882317062, 5107.923381149286, 5047.116754567955, 5059.898802023958, 5129.871753206181, 5135.460776618457, 5152.51051150142, 5091.083604951107, 5171.974140129313, 5179.14544100223, 5179.637425380225, 5205.791768329263, 4797.304390863305, 4920.409550853885, 5025.547700706954, 5076.187809950427, 5077.339945807058, 5349.331333583302, 5425.240466334716, 5426.050441172819, 5443.129099344086, 5471.288732464794, 6012.368701286389, 6042.154098426224, 6094.451499365078, 6098.664573448458, 6107.938920610782, 5769.884602307972, 5921.052631578969, 6004.219451471325, 6053.7578496860515, 6114.175715401369, 5613.663180209201, 5682.51698605619, 5688.488036076773, 5697.829065128053, 5708.229389032469, 6101.450869421773, 6138.539609529304, 6153.1693221415435, 6154.938450615526, 6167.352427995085, 5784.566157538202, 5906.49794767441, 5908.586398952032, 5910.734016969247, 5915.497182739516, 5712.285964254468, 5796.5072968797285, 5989.970050149808, 6123.374132580163, 6129.295131059986, 5859.033259512218, 5885.058390657474, 5890.469857712741, 5905.291365036223, 5906.7637294508595, 5705.71471426427, 5918.112283157561, 5931.555133364928, 5941.58408911372, 5955.106733989936, 4514.164879497303, 4565.977170114194, 4572.4055872737, 4596.057808149321, 4604.447466303998, 4096.979515102465, 4112.588741125864, 4119.588041195856, 4147.834086636501, 4169.791510424467, 5506.944930550643, 5623.775048997994, 5703.201551782754, 5717.542596592262, 5718.085106382959, 5986.132010858401, 6057.3336932937345, 6128.080787881764, 6130.612163469634, 6131.040261761288, 5539.279893613804, 5588.1059030555725, 5590.552755779528, 5598.1322894951345, 5607.775688972395, 5055.974720126376, 5087.084324821493, 5134.974325128425, 5155.252488389163, 5167.612429067835, 5946.197263369476, 6066.605670631395, 6101.877962440726, 6106.389361063858, 6106.664133472702, 5864.501517371071, 5907.202527658711, 5919.023361145363, 5929.970350148395, 5931.495822855106, 6067.24159480065, 6081.996470582304, 6088.756449741961, 6098.115773212948, 6205.906911396242, 6003.759849605967, 6037.0, 6044.818655440344, 6058.485028772604, 6060.363661815446, 6097.725602347817, 6129.632222066691, 6130.356312587114, 6136.754529818757, 6146.108814222002, 5656.3495198051105, 5737.942620573741, 5745.597808153389, 5863.120531920246, 5965.105234214729, 5725.971370143123, 5907.91138132937, 5916.378780228014, 5921.5558833086825, 5922.703864806828, 5749.108888122348, 5821.068629019336, 5822.039363504974, 5831.70841457917, 5840.357560668408, 5526.419725928719, 5543.1685247213245, 5655.066913959151, 5704.885902281848, 5724.656520608777, 5508.0, 5733.942660573341, 5814.592978491465, 5826.563007774349, 5827.067669172912], "unit": "ms", "name": "dojo.html", "value": 5495.203095925174}, {"lowerIsBetter": false, "replicates": [622.7042154976386, 628.1708145248273, 667.4526887951878, 668.7394261816474, 687.2200052939912, 40458.59541404585, 41583.0, 41915.79042104789, 41930.0, 42073.15853682924, 44997.77501112498, 45717.0, 45828.770856145675, 45871.31193032107, 45906.540934590645, 8673.91326086739, 8773.16654917785, 8817.73546793594, 8857.202851743341, 8865.689700860472, 8558.52928088958, 8620.741377758646, 8651.524166170859, 8710.869336959951, 8722.476651400904, 8664.696735614254, 8745.43154694946, 8753.956230218871, 8769.605367758466, 8812.735617931472, 8600.612972416257, 8641.438306510057, 8675.436096653697, 8678.86981695275, 8700.26047785939, 8537.274331681814, 8632.611532481053, 8646.394752367336, 8682.13178682133, 8691.39160258782, 42940.3558946616, 43227.919302017384, 43307.56692433098, 43348.349774753086, 43511.34732979008, 3418.265073009315, 3427.143214196451, 3459.6713312235297, 3516.3670539302916, 4184.184084103601, 31655.683443165504, 32077.51883721746, 32360.35279294401, 32606.0, 32849.0, 3947.782871942042, 4021.356582946744, 4061.756294622332, 4086.244044851712, 4126.257273690734, 291852.0, 292112.0, 292361.99999999785, 293385.0, 296324.0, 43978.56021439745, 44321.335179972324, 64946.0, 65155.674221628586, 65344.673276633315, 42447.787761060994, 42699.7865010673, 42720.78639606782, 42962.78518607449, 42968.14063718771, 14905.70188596222, 15006.849931500763, 15037.699246015018, 15079.623009424851, 15101.0, 11598.420078996185, 11610.187286890006, 11622.07023438123, 11638.243514171552, 11681.065514758799, 14786.630334241514, 15440.691186176213, 15453.227338633023, 15490.380384784483, 15529.844701553066, 6117.143599896018, 6259.342769009279, 6328.6202827830475, 6359.3640635936035, 6372.681365931685, 1011.8482227665909, 1042.8852826189113, 1052.1057101463696, 1053.9683809485728, 1085.804555180075, 28603.28491787722, 28614.570781438295, 28824.279393015342, 29063.56404653932, 29296.853515732284, 1115.66530040989, 1131.813250813623, 1174.0, 1230.7046308885804, 1250.8936740376987, 17128.0, 17892.0, 17905.641887162183, 18160.273589056553, 18189.63620727578, 414849.0, 760320.0, 788343.0, 794940.0, 805685.9715701501, 59142.70428647829, 60162.699186504666, 60304.0, 60498.0, 60536.09195862066, 1457.8396376398587, 1491.2394678713717, 1493.2906869237243, 1495.7008598280388, 1506.4049700368294, 30089.398212036074, 30390.84804575963, 30478.54793713821, 31362.68637313689, 31628.0, 46882.0, 47120.528794711616, 47382.28926566035, 47500.52499474961, 47570.762146189045, 317707.0, 319363.0, 319441.0, 320483.0, 320797.0, 34157.0, 48609.0, 48781.756091219315, 48974.0, 49486.50513494819, 44489.0, 45110.77444612756, 45674.54325456703, 45927.54072459233, 45928.31107533323, 37950.240995180495, 38613.61386386213, 39023.2195356097, 39218.21563568655, 39715.80142099386, 38959.415608765325, 39181.80409097936, 39781.40327895026, 39812.0, 39887.40168897527, 44019.11961760811, 44201.0, 44264.0, 45135.32297015482, 45513.54486455093, 33689.66310336865, 33768.0, 34214.31571368608, 34223.657763422045, 34659.653403466655, 26665.066722664615, 27669.0, 28326.0, 30352.0, 31158.688413116484], "unit": "ms", "name": "ext.html", "value": 19710.925973110338}, {"lowerIsBetter": false, "replicates": [394.5265681182582, 395.36938582960204, 397.4852565927125, 398.279114802208, 399.03831765445284, 15013.849861501381, 16186.0, 16726.996380217195, 17314.740278895828, 17351.30594776209, 11788.233764805304, 12149.331786751725, 12153.939230303837, 17110.058946757956, 18454.815451845476, 5011.874703132415, 5096.8470945871495, 5112.36095488064, 5116.769745361467, 5321.866953326159, 5323.041852466555, 5418.078926582491, 5453.972730136344, 5476.945230547703, 5477.452254774531, 5396.325459317585, 5446.618736688433, 5457.208704737811, 5856.824295271127, 6114.144019837227, 6174.598651087687, 6176.197094377747, 6177.722002509875, 6178.721957511878, 6180.134781130645, 5214.97392513035, 5340.385855626614, 5350.357957045179, 5501.972490137564, 5515.393306736256, 13321.933390333083, 13413.731725365438, 13465.730685386336, 17863.374781882572, 20485.897570512054, 1954.9315773947844, 2024.44327809852, 2043.5606344635974, 2054.578811343671, 2161.0599389265562, 9693.806123877483, 9840.311178217527, 10100.545475453622, 10110.331795253775, 10180.38917664935, 1852.685043542601, 1884.896330701811, 1910.866239363245, 1927.5662975830467, 1930.7007413850736, 61248.69375653138, 62715.6864215676, 63532.0, 63825.0, 65091.67454162699, 10970.067544258827, 10986.08143459064, 11004.614838480775, 11113.94443027796, 11115.388653623966, 14247.358868850926, 14253.78842798353, 14315.21266330341, 14330.140191588538, 14358.856411435752, 8115.8782618260775, 8128.309093726981, 8169.0, 8182.590870456454, 8188.754337369888, 7815.68737250515, 7830.099538553025, 7848.882266766003, 7875.56684382353, 7879.251471110236, 4618.376519169936, 4752.619790416758, 4763.3807605011125, 4842.0, 4862.756862156878, 1904.1431355889904, 1957.354073155855, 1986.0, 2008.4677560446494, 2014.2345908554948, 897.9955100224588, 996.7159359582629, 1059.89930956559, 1067.7330667333167, 1113.1984970820995, 17080.302916697758, 17754.467365979042, 18018.729719054223, 18103.275868965356, 18268.63462730738, 966.9613215471302, 972.9367591106555, 1032.385730490357, 1056.6354607660344, 1059.4490864750287, 10102.747431314276, 10423.895761042444, 10434.269601127848, 10510.894891051144, 10575.312604680825, 483437.0, 619627.0, 621294.0, 622926.0, 624927.0, 82545.17454825375, 82620.0, 82939.58530207431, 84440.15559844446, 84559.57720211359, 1173.4015652017533, 1195.2589394575418, 1207.269601890861, 1210.8183772434206, 1227.300438749904, 16625.0, 16793.74809377836, 16866.578335541708, 17012.74480882763, 17081.572960675585, 33023.174420639676, 33104.0, 33165.83417082899, 34854.12864678403, 37576.248475030894, 43905.0, 46255.0, 47290.52709472861, 47347.76326118485, 49676.25485617791, 9891.950540247253, 10100.393976361442, 10611.0, 10645.041946224877, 10656.89343106559, 17733.113344332472, 17781.46655600334, 17994.91002544979, 18199.818001820342, 18583.907080464513, 13214.207147571176, 13663.18020918748, 13752.31238438094, 14683.706325873636, 14933.0, 14717.55847324582, 14798.778018329518, 14987.325570349143, 15019.09885406879, 15383.077015379113, 15238.085714857145, 15280.083195008336, 15289.847101528841, 15578.143202123993, 15625.218739062773, 9765.2676049298, 9908.603655853685, 10106.0, 10191.694249172537, 10201.489925503844, 10826.837597435888, 14623.853761462675, 15536.0, 15787.368505259661, 15927.283272252545], "unit": "ms", "name": "jquery.html", "value": 9205.709906364009}, {"lowerIsBetter": false, "replicates": [1537.9538613841585, 1577.195630228583, 1613.4111049466944, 1804.1700817623891, 1877.164661725532, 7915.366770658348, 7955.801104972378, 7973.40199485038, 8111.472754270975, 8135.837283254339, 8057.516549007064, 8154.347652187811, 8172.305354044914, 8187.549684767336, 8229.711960081399, 2224.377174391173, 2241.2267767620147, 2255.0979608156704, 2258.0403328585367, 2264.230161745006, 2333.626619740833, 2349.3186975777003, 2349.788519033287, 2357.5284943011466, 2384.821138414617, 2265.660150977358, 2308.9538209235807, 2313.375388645065, 2335.241046659842, 2357.95284094318, 2293.323469576479, 2315.22439982606, 2322.140807901079, 2335.7897789198882, 2339.4736184358553, 2375.6080246759266, 2385.9284221473386, 2386.4869053153484, 2397.496525729599, 2401.543706695722, 7974.082980457264, 8021.558814265213, 8022.237887400687, 8034.839303213961, 8036.4776289541, 4685.789139488731, 4784.856454306341, 4820.879478013043, 4829.782659780319, 4830.275458681191, 2982.3140677644046, 3007.7593792496546, 3032.0, 3044.0867739678006, 3062.969370306291, 949.0746522140857, 963.7879666473365, 971.621067783565, 972.8200282947678, 983.1544871410653, 10941.945290273577, 11034.006939375495, 11040.723981900355, 11048.889511104946, 11048.944755276252, 4141.710080294411, 4182.309918863414, 4196.223698615766, 4217.873463796091, 4222.261104306734, 8910.821783564292, 9014.504202268807, 9019.413738107001, 9022.86465703015, 9034.23209027227, 4732.408448943882, 4741.1465936131135, 4756.738379389167, 4757.833475828329, 4759.309900064472, 4353.325234588644, 4360.215161271001, 4362.716423432466, 4390.604845563915, 4392.165488557228, 3431.039308993486, 3444.9655503445147, 3461.7057550108525, 3464.965350346464, 3499.2476617527354, 1021.7190272675074, 1046.7801761629992, 1060.5068643081004, 1064.744461329291, 1066.461436974323, 964.6479035152119, 1112.7941330853819, 1130.9321440713584, 1299.1815156451564, 1410.2173293821822, 7174.461915356369, 7218.8917166242545, 7226.168990566152, 7262.673179706926, 7301.744438944612, 642.325558163926, 657.1555551116792, 659.4954859532462, 667.0328024364691, 794.0693566844145, 5320.494553017457, 5399.83800485986, 5418.160185171305, 5422.539084177889, 5428.240046393508, 9190.03504632004, 9226.630934762668, 9491.905080949102, 9602.423854568748, 9705.5147242639, 9458.101480359355, 9464.0, 9529.952350238344, 9544.95227523858, 9565.091316324939, 7486.5508069516, 7550.093988721389, 7550.509216900884, 7553.924460755432, 7615.5430674159725, 7099.680514376762, 7101.609411482418, 7121.038659780863, 7122.715091396286, 7169.4981351304905, 8324.875126872981, 8537.615807288563, 8555.401121921655, 8595.613197406257, 8714.738557843275, 8677.739667809976, 8785.0, 8787.34094942869, 8791.120887911158, 8911.108889111038, 6712.060311556288, 6880.277570854988, 7318.3047610476915, 7318.634068296457, 7334.083239595051, 7564.735234266775, 7607.657655405409, 7629.618519074135, 7636.12184598756, 7676.193999629959, 6815.727370905108, 7073.893891591527, 7236.4210863131875, 7282.162551306667, 7313.853722925618, 7065.788026359218, 7098.609576473344, 7119.857602848017, 7176.138863336433, 7236.131664200329, 7284.125904891447, 7294.161171465349, 7316.487845850952, 7317.085364329459, 7331.340179383881, 6365.522585806176, 6380.808575742735, 6399.488040956619, 6415.743370265323, 6438.806835794933, 6205.751769929152, 6315.147455093504, 6346.048092786119, 6349.0, 6351.174347335002], "unit": "ms", "name": "mootools.html", "value": 4465.753667166728}, {"lowerIsBetter": false, "replicates": [362.67540551206673, 368.6810908564093, 369.6248307967414, 370.4480324316767, 375.363758429462, 6251.874962500748, 6309.558330916838, 6358.45953093987, 6379.9681001595045, 6381.266154392246, 6159.8768024639485, 6270.874582508359, 6271.404216599416, 6292.528060395466, 6295.653739044351, 4831.347768051312, 4840.128776820171, 4848.054629347279, 4854.587360074398, 4856.975715121437, 4864.902701945959, 4872.7563621818945, 4886.267059941019, 4890.486498917616, 4901.313816065754, 4760.952390476103, 4849.224124140138, 4866.148424025799, 4883.023395320933, 4884.462709101996, 4850.563449289563, 4854.87862803431, 4861.586765124968, 4870.074685809703, 4872.56146946773, 4291.871243862689, 4305.913881722348, 4308.6983911126235, 4310.719803212813, 4323.675724320657, 5888.941110588882, 6006.279246490405, 6010.459058684695, 6011.5190784737115, 6021.09683547467, 5683.886322273573, 5687.118496633028, 5688.573356998241, 5689.975804355215, 5698.6865722385255, 6643.701033453458, 6650.068990341356, 6663.0, 6665.866682666368, 6667.499937504706, 4756.7145971241835, 4770.189067858472, 4781.569658730697, 4788.209945359012, 4793.113274044278, 6755.898661520081, 6868.141482314661, 6915.757948471779, 6917.169939607279, 6925.065116209297, 4877.414710234794, 4879.2925025871045, 4889.975550122226, 4896.608271338285, 4911.214205727067, 4946.455889852114, 4954.578860796801, 4955.529224723646, 4958.157113290677, 4964.553190212898, 5543.223948647193, 5653.802116925888, 5655.236543066716, 5670.206171136044, 5674.2339784129435, 6695.0, 6704.396604305538, 6714.52998290115, 6714.731410743613, 6749.257581666013, 1678.4796713019002, 1722.7329763886617, 1727.6976529107355, 1732.618823858749, 1741.3469948769211, 1148.8219326004482, 1165.452237448398, 1171.9335404781607, 1173.342927960345, 1184.6505280942142, 6486.513511486657, 6524.804255872332, 6525.673716314165, 6530.216374035146, 6555.115059466911, 6899.931000689929, 6903.378695917391, 6904.206016308089, 6907.378335949788, 6914.827129321707, 6409.442759268558, 6487.643179625166, 6533.542652014314, 6544.640044797582, 6546.5744726593575, 3718.9442158367647, 3744.063984003999, 3746.0447585865977, 3748.9877733011936, 3749.0439937816227, 7123.501354905107, 7132.500724949204, 7141.178764442052, 7146.964265178744, 7170.4622153338705, 6886.724531018804, 6992.230854605989, 6997.0, 7026.578405295699, 7062.788116356517, 7141.785746427511, 7143.714251429885, 7145.356917877416, 7145.785626431215, 7146.3568278855155, 6849.452043836581, 6889.207741109636, 6902.102726645504, 6909.170899491892, 6919.0, 6641.900371494528, 6793.966030169818, 6800.047993280846, 6807.9319206807295, 6828.863422731418, 7049.823754405976, 7113.857722845618, 7119.2168861426235, 7124.430045596237, 7130.322619351154, 4786.2342025277185, 4801.567858892717, 4806.47128815837, 4810.831620893252, 4819.084373968934, 6794.72821087151, 6869.656517174221, 6886.586804791728, 6886.965565172142, 6899.310068993061, 6622.304658011032, 6657.267700553032, 6659.367360100783, 6662.6335551545135, 6682.264950855305, 6636.369544893228, 6655.267920528835, 6655.833604159935, 6657.06801047844, 6665.3001434850585, 6461.579997300349, 6518.902216466851, 6559.147310849559, 6561.540692151503, 6564.770233041821, 6656.23453302857, 6656.567323123982, 6660.700268487833, 6693.933060669331, 6697.598144111369, 6485.383888530582, 6496.563788579283, 6535.901961470487, 6540.574862633914, 6549.377809108127], "unit": "ms", "name": "prototype.html", "value": 5082.397200926938}, {"lowerIsBetter": false, "replicates": [715.7709532949452, 744.2520267131532, 746.0487877955609, 861.655337864854, 906.8186362727452, 13166.407511661975, 13230.073894827354, 13262.867371326283, 13285.601431957033, 13362.866371336284, 13493.6506349365, 13495.0, 13644.590662280123, 13663.590092297221, 13672.111312764688, 899.1008991009007, 911.8723378726984, 925.5464822237122, 931.4923366765096, 933.6032186320821, 903.7288813356, 911.5305617606938, 915.1351972386097, 915.4049867586056, 916.138829500271, 966.6278482784144, 976.9120779129877, 980.691082309074, 982.5087456271864, 982.6609819612222, 971.5142428785607, 977.5258999385293, 977.6236149082583, 978.0757184460688, 978.3640633588153, 711.1430725975239, 712.597382478903, 712.8645557344088, 714.103799731339, 716.451914285572, 14445.133292002514, 14492.0, 14497.130172189702, 14525.491607793676, 14538.273086345745, 12241.632751017483, 12672.303023333712, 13059.934700326532, 13139.211647301097, 13313.600591982256, 10918.945405272923, 11054.723631909186, 11322.94338528302, 11726.413679316085, 11759.941200293944, 3628.2199327144526, 3653.178034942117, 3754.607109681679, 3798.582155962842, 3811.7712937223855, 48164.518354816704, 48193.99999999965, 48357.0, 48672.0, 48676.26985595219, 9347.0, 9580.18568421678, 9819.950900245452, 9948.701538953843, 10183.18534517237, 19072.14175362112, 19170.0, 19211.135498902582, 19236.71144932827, 19273.903630482037, 7890.723824666109, 7917.445778795429, 8009.559474228973, 8020.318272946748, 8202.343812494986, 4402.3836662867225, 4623.468301145344, 4684.227102528044, 4738.170820106537, 4768.998510312804, 3085.768567357457, 3113.2839446927333, 3131.9686803131676, 3135.1848519385126, 3143.449896268144, 584.9181114643953, 593.0896074525582, 599.6162456028145, 600.2287061126519, 602.1569802276847, 581.4214856218006, 586.8521212362817, 662.8259309464962, 718.60476737794, 731.5537522111508, 8841.115888411236, 9088.727338179866, 9203.723888283363, 9209.907900921038, 9214.401063930824, 509.4090854608636, 611.0, 648.1088503307951, 689.7378995981495, 730.7990302666809, 4211.768352740629, 4281.678874084456, 4383.101464199832, 4415.381846541487, 4532.637389008872, 58689.0, 58837.0, 59388.0, 60027.699861501285, 60107.699461502416, 53843.0, 54415.45584544183, 54684.453155467934, 55099.0, 55376.44623553794, 48047.519524805, 48604.75697621489, 48656.27015594769, 48861.755691222024, 48944.26583601249, 8658.350623703122, 8770.561471926505, 8959.283257339266, 9031.277497800029, 9133.543322833964, 35419.29161416809, 36205.637943620226, 36278.637213627524, 36542.45186322154, 36860.447093294155, 40728.389074163315, 46185.538144619466, 46258.30612540882, 47521.52478475171, 47522.04955900932, 11190.104791616814, 11246.775064498828, 11277.32336059839, 11284.32294062359, 11488.48301826403, 11354.772904542027, 11495.252808567417, 11570.94214528922, 11865.288082715064, 12104.092193085378, 10665.253432259979, 10941.398223097487, 11279.09767218604, 12960.740785184054, 13100.410481528545, 11921.165518413974, 12112.21270617407, 12311.753764924471, 12404.25574465535, 13164.275964822027, 10471.94764026175, 12067.57763478274, 12860.485580576673, 12943.09398342107, 13353.866461335263, 10182.541785619813, 10349.689509314732, 10435.582576696846, 10601.151907847508, 10949.397783122005, 10236.846447303147, 10379.325343852626, 10510.527026283988, 10516.631917882838, 10682.8397574038], "unit": "ms", "name": "yui.html", "value": 6649.272441534126}], "name": "dromaeo_css", "value": 7293.244155952743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 112.0, 112.0, 111.0, 122.0, 111.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 148.0, 160.0, 121.0, 154.0, 147.0, 123.0, 164.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 165.0, 167.0, 160.0, 159.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 72.0, 164.0, 73.0, 70.0, 70.0, 70.0, 161.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 142.0, 93.0, 92.0, 93.0, 137.0, 94.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 65.0, 63.0, 65.0, 59.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 80.0, 90.0, 88.0, 81.0, 84.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 113.0, 115.0, 120.0, 114.0, 122.0, 123.0, 114.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 144.0, 146.0, 148.0, 145.0, 149.0, 146.0, 149.0, 153.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 64.0, 66.0, 65.0, 64.0, 68.0, 65.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.4}], "name": "kraken", "value": 1501.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.11229946524065], "unit": "score", "name": "Richards", "value": 211.24716800000004}, {"lowerIsBetter": false, "replicates": [165.26194017517767], "unit": "score", "name": "DeltaBlue", "value": 400.08001799999994}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [916.5902841429881], "unit": "score", "name": "RayTrace", "value": 807.327999}, {"lowerIsBetter": false, "replicates": [544.6623093681917], "unit": "score", "name": "Earley", "value": 1223.6260680000005}, {"lowerIsBetter": false, "replicates": [10755.31914893617], "unit": "score", "name": "Boyer", "value": 61.96589713155287}, {"lowerIsBetter": false, "replicates": [24463.414634146342], "unit": "score", "name": "RegExp", "value": 37.23866899302096}, {"lowerIsBetter": false, "replicates": [515.4639175257732], "unit": "score", "name": "Splay", "value": 158.09254}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23291.046146072906}]} 15:00:29 INFO - RETURN: dromaeo_css: 7293.24 15:00:29 INFO - RETURN: kraken: 1501.80 15:00:29 INFO - RETURN: v8_7: 23291.05 15:00:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23291.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7293.24"}}} 15:00:29 INFO - Return code: 0 15:00:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:00:29 INFO - # TBPL SUCCESS # 15:00:29 INFO - Running post-action listener: _resource_record_post_action 15:00:29 INFO - Running post-run listener: _resource_record_post_run 15:00:30 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 405504; Write bytes: 513691648; Read time: 36; Write time: 501224 15:00:30 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248102912; Read time: 0; Write time: 326576 15:00:30 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 405504; Write bytes: 264724480; Read time: 36; Write time: 174600 15:00:30 INFO - Running post-run listener: _upload_blobber_files 15:00:30 INFO - Blob upload gear active. 15:00:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:00:30 INFO - Copying logs to upload dir... 15:00:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.253885 ========= master_lag: 75.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 16 secs) (at 2016-01-04 15:01:45.971363) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-04 15:01:45.974763) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009132 build_url: 'https://queue.taskcluster.net/v1/task/07y8tk-RSiWMgVKV3D-Arw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.69 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-04 15:01:46.670960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 15:01:46.671374) ========= 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-1451947017.958261-1291483555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 15:01:46.919880) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-01-04 15:01:46.920198) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-01-04 15:01:48.242826) ========= ========= Total master_lag: 76.83 =========