builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1451493569.0 results: success (0) buildid: 20151230055836 builduid: de3bc310d3bc45e2ad294c00058fad87 revision: 3c125ce5d3b1ec5367d9f788f6096b085a04a72a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:28.998125) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:28.998647) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:28.998951) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006336 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.022340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.022648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.035718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.036133) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.085446) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.085747) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.086134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.086434) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 08: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% 39.8M=0s 2015-12-30 08:39:29 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097533 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.196394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.196707) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.246254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.246610) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c125ce5d3b1ec5367d9f788f6096b085a04a72a --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 3c125ce5d3b1ec5367d9f788f6096b085a04a72a --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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 08:39:29,689 truncating revision to first 12 chars 2015-12-30 08:39:29,689 Setting DEBUG logging. 2015-12-30 08:39:29,690 attempt 1/10 2015-12-30 08:39:29,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c125ce5d3b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 08:39:29,910 unpacking tar archive at: mozilla-aurora-3c125ce5d3b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515638 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.775566) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.775879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.786170) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.786534) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 08:39:29.787001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-30 08:39:29.787295) ========= /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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:39:30 INFO - MultiFileLogger online at 20151230 08:39:30 in /builds/slave/test-pgo 08: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 08:39:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:39:30 INFO - {'append_to_log': False, 08:39:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:39:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:39:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:39:30 INFO - 'branch': 'Mozilla-Aurora', 08:39:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:30 INFO - 'config_files': ('talos/linux_config.py',), 08:39:30 INFO - 'default_actions': ('clobber', 08:39:30 INFO - 'read-buildbot-config', 08:39:30 INFO - 'download-and-extract', 08:39:30 INFO - 'populate-webroot', 08:39:30 INFO - 'create-virtualenv', 08:39:30 INFO - 'install', 08:39:30 INFO - 'run-tests'), 08:39:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:30 INFO - 'download_minidump_stackwalk': True, 08:39:30 INFO - 'download_symbols': 'ondemand', 08:39:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:30 INFO - 'installer_path': 'installer.exe', 08:39:30 INFO - 'log_level': 'info', 08:39:30 INFO - 'log_name': 'talos', 08:39:30 INFO - 'log_to_console': True, 08:39:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:39:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:39:30 INFO - 'opt_config_files': (), 08:39:30 INFO - 'pip_index': False, 08:39:30 INFO - 'sps_profile': False, 08:39:30 INFO - 'sps_profile_interval': 0, 08:39:30 INFO - 'suite': 'dromaeojs-e10s', 08:39:30 INFO - 'system_bits': '32', 08:39:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:30 INFO - 'title': 'talos-linux64-ix-047', 08:39:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:30 INFO - 'use_talos_json': True, 08:39:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:39:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:30 INFO - 'work_dir': 'build'} 08:39:30 INFO - ##### 08:39:30 INFO - ##### Running clobber step. 08:39:30 INFO - ##### 08:39:30 INFO - Running pre-action listener: _resource_record_pre_action 08:39:30 INFO - Running main action method: clobber 08:39:30 INFO - rmtree: /builds/slave/test-pgo/build 08:39:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:39:30 INFO - Running post-action listener: _resource_record_post_action 08:39:30 INFO - ##### 08:39:30 INFO - ##### Running read-buildbot-config step. 08:39:30 INFO - ##### 08:39:30 INFO - Running pre-action listener: _resource_record_pre_action 08:39:30 INFO - Running main action method: read_buildbot_config 08:39:30 INFO - Using buildbot properties: 08:39:30 INFO - { 08:39:30 INFO - "properties": { 08:39:30 INFO - "buildnumber": 30, 08:39:30 INFO - "product": "firefox", 08:39:30 INFO - "script_repo_revision": "production", 08:39:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:39:30 INFO - "repository": "", 08:39:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:39:30 INFO - "buildid": "20151230055836", 08:39:30 INFO - "slavename": "talos-linux64-ix-047", 08:39:30 INFO - "pgo_build": "True", 08:39:30 INFO - "basedir": "/builds/slave/test-pgo", 08:39:30 INFO - "project": "", 08:39:30 INFO - "platform": "ubuntu64_hw", 08:39:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:39:30 INFO - "slavebuilddir": "test", 08:39:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:39:30 INFO - "branch": "mozilla-aurora", 08:39:30 INFO - "repo_path": "releases/mozilla-aurora", 08:39:30 INFO - "stage_platform": "linux64-pgo", 08:39:30 INFO - "builduid": "de3bc310d3bc45e2ad294c00058fad87", 08:39:30 INFO - "revision": "3c125ce5d3b1ec5367d9f788f6096b085a04a72a" 08:39:30 INFO - }, 08:39:30 INFO - "sourcestamp": { 08:39:30 INFO - "repository": "", 08:39:30 INFO - "hasPatch": false, 08:39:30 INFO - "project": "", 08:39:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:39:30 INFO - "changes": [ 08:39:30 INFO - { 08:39:30 INFO - "category": null, 08:39:30 INFO - "files": [ 08:39:30 INFO - { 08:39:30 INFO - "url": null, 08:39:30 INFO - "name": "https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 08:39:30 INFO - } 08:39:30 INFO - ], 08:39:30 INFO - "repository": "", 08:39:30 INFO - "rev": "3c125ce5d3b1ec5367d9f788f6096b085a04a72a", 08:39:30 INFO - "who": "cbook@mozilla.com", 08:39:30 INFO - "when": 1451493550, 08:39:30 INFO - "number": 7403093, 08:39:30 INFO - "comments": "Bug 1220904 - Message that Old Sync accounts are deprecated and going away. r=nalexander, l10n=flod, a=sylvestre", 08:39:30 INFO - "project": "", 08:39:30 INFO - "at": "Wed 30 Dec 2015 08:39:10", 08:39:30 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:39:30 INFO - "revlink": "", 08:39:30 INFO - "properties": [ 08:39:30 INFO - [ 08:39:30 INFO - "buildid", 08:39:30 INFO - "20151230055836", 08:39:30 INFO - "Change" 08:39:30 INFO - ], 08:39:30 INFO - [ 08:39:30 INFO - "builduid", 08:39:30 INFO - "de3bc310d3bc45e2ad294c00058fad87", 08:39:30 INFO - "Change" 08:39:30 INFO - ], 08:39:30 INFO - [ 08:39:30 INFO - "pgo_build", 08:39:30 INFO - "True", 08:39:30 INFO - "Change" 08:39:30 INFO - ] 08:39:30 INFO - ], 08:39:30 INFO - "revision": "3c125ce5d3b1ec5367d9f788f6096b085a04a72a" 08:39:30 INFO - } 08:39:30 INFO - ], 08:39:30 INFO - "revision": "3c125ce5d3b1ec5367d9f788f6096b085a04a72a" 08:39:30 INFO - } 08:39:30 INFO - } 08:39:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 08:39:30 INFO - Running post-action listener: _resource_record_post_action 08:39:30 INFO - ##### 08:39:30 INFO - ##### Running download-and-extract step. 08:39:30 INFO - ##### 08:39:30 INFO - Running pre-action listener: _resource_record_pre_action 08:39:30 INFO - Running main action method: download_and_extract 08:39:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 08: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')]} 08:39:30 INFO - https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:39:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/test_packages.json 08:39:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/test_packages.json 08:39:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:39:38 INFO - Downloaded 1302 bytes. 08:39:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:39:38 INFO - Using the following test package requirements: 08:39:38 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:39:38 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:39:38 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'jsshell-linux-x86_64.zip'], 08:39:38 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:39:38 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:39:38 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:39:38 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:39:38 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:39:38 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:39:38 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:39:38 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:39:38 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:39:38 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')]} 08:39:38 INFO - https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:39:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:43 INFO - Downloaded 23023578 bytes. 08:39:43 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 08:39:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:43 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 08:39:45 INFO - Return code: 0 08:39:45 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 08: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')]} 08:39:45 INFO - https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:46 INFO - Downloaded 23023578 bytes. 08:39:46 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 08:39:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:39:46 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 08:39:47 INFO - Return code: 0 08:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:47 INFO - https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:48 INFO - Downloaded 11132038 bytes. 08:39:48 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 08:39:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:39:48 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 08:39:48 INFO - Return code: 0 08: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')]} 08:39:48 INFO - https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:39:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:39:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:39:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_wwgobedRe2X1qgHrzqA-g/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 08:39:49 INFO - Downloaded 58086656 bytes. 08:39:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:39:49 INFO - mkdir: /builds/slave/test-pgo/properties 08:39:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:39:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:39:49 INFO - Contents: 08:39:49 INFO - build_url:https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:39:49 INFO - Running post-action listener: _resource_record_post_action 08:39:49 INFO - Running post-action listener: set_extra_try_arguments 08:39:49 INFO - ##### 08:39:49 INFO - ##### Running populate-webroot step. 08:39:49 INFO - ##### 08:39:49 INFO - Running pre-action listener: _resource_record_pre_action 08:39:49 INFO - Running main action method: populate_webroot 08:39:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:49 INFO - '--tppagecycles', 08:39:49 INFO - '7'], 08:39:49 INFO - 'tests': ['tsvgm']}}, 08:39:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:39:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:39:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:39:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'tests': ['damp', 'tps']}, 08:39:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['damp', 'tps']}, 08:39:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:39:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:49 INFO - 'other': {'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'other_l64': {'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'other_nol64': {'tests': ['a11yr', 08:39:49 INFO - 'ts_paint', 08:39:49 INFO - 'tpaint', 08:39:49 INFO - 'sessionrestore', 08:39:49 INFO - 'sessionrestore_no_auto_restore']}, 08:39:49 INFO - 'svgr': {'tests': ['tsvgx', 08:39:49 INFO - 'tsvgr_opacity', 08:39:49 INFO - 'tart', 08:39:49 INFO - 'tscrollx', 08:39:49 INFO - 'cart']}, 08:39:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['tsvgx', 08:39:49 INFO - 'tsvgr_opacity', 08:39:49 INFO - 'tart', 08:39:49 INFO - 'tscrollx', 08:39:49 INFO - 'cart']}, 08:39:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'tests': ['tp5o']}, 08:39:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'talos_options': ['--e10s'], 08:39:49 INFO - 'tests': ['tp5o']}, 08:39:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'talos_options': ['--xperf_path', 08:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:49 INFO - 'tests': ['tp5n']}, 08:39:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:49 INFO - 'talos_options': ['--e10s', 08:39:49 INFO - '--xperf_path', 08:39:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:49 INFO - 'tests': ['tp5n']}}, 08:39:49 INFO - 'talos.zip': {'path': '', 08:39:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:49 INFO - Running post-action listener: _resource_record_post_action 08:39:49 INFO - ##### 08:39:49 INFO - ##### Running create-virtualenv step. 08:39:49 INFO - ##### 08:39:49 INFO - Running pre-action listener: _resource_record_pre_action 08:39:49 INFO - Running main action method: create_virtualenv 08:39:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:39:49 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 08:39:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:39:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:49 INFO - Using real prefix '/usr' 08:39:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:39:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:52 INFO - Installing pip.................done. 08:39:52 INFO - Return code: 0 08:39:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:39:52 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 08:39:52 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 08:39:52 INFO - Using env: {'DISPLAY': ':0', 08:39:52 INFO - 'HOME': '/home/cltbld', 08:39:52 INFO - 'LANG': 'en_US.UTF-8', 08:39:52 INFO - 'LANGUAGE': 'en_US:en', 08:39:52 INFO - 'LOGNAME': 'cltbld', 08:39:52 INFO - 'MAIL': '/var/mail/cltbld', 08:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:52 INFO - 'MOZ_NO_REMOTE': '1', 08:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:52 INFO - 'NO_EM_RESTART': '1', 08:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:52 INFO - 'SHELL': '/bin/bash', 08:39:52 INFO - 'SHLVL': '1', 08:39:52 INFO - 'TERM': 'linux', 08:39:52 INFO - 'TMOUT': '86400', 08:39:52 INFO - 'USER': 'cltbld', 08:39:52 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:52 INFO - '_': '/tools/buildbot/bin/python'} 08:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:39:52 INFO - Cleaning up... 08:39:52 INFO - Return code: 0 08:39:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:39:52 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 08:39:52 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 08:39:52 INFO - Using env: {'DISPLAY': ':0', 08:39:52 INFO - 'HOME': '/home/cltbld', 08:39:52 INFO - 'LANG': 'en_US.UTF-8', 08:39:52 INFO - 'LANGUAGE': 'en_US:en', 08:39:52 INFO - 'LOGNAME': 'cltbld', 08:39:52 INFO - 'MAIL': '/var/mail/cltbld', 08:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:52 INFO - 'MOZ_NO_REMOTE': '1', 08:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:52 INFO - 'NO_EM_RESTART': '1', 08:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:52 INFO - 'SHELL': '/bin/bash', 08:39:52 INFO - 'SHLVL': '1', 08:39:52 INFO - 'TERM': 'linux', 08:39:52 INFO - 'TMOUT': '86400', 08:39:52 INFO - 'USER': 'cltbld', 08:39:52 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:52 INFO - '_': '/tools/buildbot/bin/python'} 08:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:52 INFO - Downloading/unpacking psutil>=0.7.1 08: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 08: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 08: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 08: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 08: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 08: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 08:39:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:39:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:39:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:54 INFO - Installing collected packages: psutil 08:39:54 INFO - Running setup.py install for psutil 08:39:54 INFO - building 'psutil._psutil_linux' extension 08:39:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:39:54 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 08:39:54 INFO - building 'psutil._psutil_posix' extension 08:39:54 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 08:39:54 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 08:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:55 INFO - Successfully installed psutil 08:39:55 INFO - Cleaning up... 08:39:55 INFO - Return code: 0 08:39:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:55 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:39:55 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 08:39:55 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 08:39:55 INFO - Using env: {'DISPLAY': ':0', 08:39:55 INFO - 'HOME': '/home/cltbld', 08:39:55 INFO - 'LANG': 'en_US.UTF-8', 08:39:55 INFO - 'LANGUAGE': 'en_US:en', 08:39:55 INFO - 'LOGNAME': 'cltbld', 08:39:55 INFO - 'MAIL': '/var/mail/cltbld', 08:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:55 INFO - 'MOZ_NO_REMOTE': '1', 08:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:55 INFO - 'NO_EM_RESTART': '1', 08:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:55 INFO - 'SHELL': '/bin/bash', 08:39:55 INFO - 'SHLVL': '1', 08:39:55 INFO - 'TERM': 'linux', 08:39:55 INFO - 'TMOUT': '86400', 08:39:55 INFO - 'USER': 'cltbld', 08:39:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:55 INFO - '_': '/tools/buildbot/bin/python'} 08:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:39:55 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 08:39:55 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 08:39:55 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 08:39:55 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 08:39:55 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 08:39:55 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 08:39:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:39:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:39:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:39:57 INFO - Installing collected packages: mozsystemmonitor 08:39:57 INFO - Running setup.py install for mozsystemmonitor 08:39:57 INFO - Successfully installed mozsystemmonitor 08:39:57 INFO - Cleaning up... 08:39:57 INFO - Return code: 0 08:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08: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')]} 08:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', '--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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08: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', '--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 08: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 --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 08:39:57 INFO - Using env: {'DISPLAY': ':0', 08:39:57 INFO - 'HOME': '/home/cltbld', 08:39:57 INFO - 'LANG': 'en_US.UTF-8', 08:39:57 INFO - 'LANGUAGE': 'en_US:en', 08:39:57 INFO - 'LOGNAME': 'cltbld', 08:39:57 INFO - 'MAIL': '/var/mail/cltbld', 08:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:57 INFO - 'MOZ_NO_REMOTE': '1', 08:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:57 INFO - 'NO_EM_RESTART': '1', 08:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:39:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:39:57 INFO - 'SHELL': '/bin/bash', 08:39:57 INFO - 'SHLVL': '1', 08:39:57 INFO - 'TERM': 'linux', 08:39:57 INFO - 'TMOUT': '86400', 08:39:57 INFO - 'USER': 'cltbld', 08:39:57 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:57 INFO - '_': '/tools/buildbot/bin/python'} 08:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - Downloading docopt-0.6.1.tar.gz 08:39:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:39:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:59 INFO - Running setup.py install for blobuploader 08:39:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:39:59 INFO - Running setup.py install for requests 08:40:00 INFO - Running setup.py install for docopt 08:40:00 INFO - Successfully installed blobuploader requests docopt 08:40:00 INFO - Cleaning up... 08:40:00 INFO - Return code: 0 08:40:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08: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')]} 08:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:00 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:40:00 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 08:40:00 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 08:40:00 INFO - Using env: {'DISPLAY': ':0', 08:40:00 INFO - 'HOME': '/home/cltbld', 08:40:00 INFO - 'LANG': 'en_US.UTF-8', 08:40:00 INFO - 'LANGUAGE': 'en_US:en', 08:40:00 INFO - 'LOGNAME': 'cltbld', 08:40:00 INFO - 'MAIL': '/var/mail/cltbld', 08:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:00 INFO - 'MOZ_NO_REMOTE': '1', 08:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:00 INFO - 'NO_EM_RESTART': '1', 08:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:00 INFO - 'SHELL': '/bin/bash', 08:40:00 INFO - 'SHLVL': '1', 08:40:00 INFO - 'TERM': 'linux', 08:40:00 INFO - 'TMOUT': '86400', 08:40:00 INFO - 'USER': 'cltbld', 08:40:00 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:00 INFO - '_': '/tools/buildbot/bin/python'} 08:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:00 INFO - Running setup.py (path:/tmp/pip-xzaBsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:00 INFO - Running setup.py (path:/tmp/pip-3cUb0w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:00 INFO - Running setup.py (path:/tmp/pip-GAJGPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:00 INFO - Running setup.py (path:/tmp/pip-8PCHsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:00 INFO - Running setup.py (path:/tmp/pip-uOhR60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:00 INFO - Running setup.py (path:/tmp/pip-7PFR3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:01 INFO - Running setup.py (path:/tmp/pip-TEKERK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:01 INFO - Running setup.py (path:/tmp/pip-CtBVcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:01 INFO - Running setup.py (path:/tmp/pip-br3uvU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:01 INFO - Running setup.py (path:/tmp/pip-Exnk7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:01 INFO - Running setup.py (path:/tmp/pip-FmHwGC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:01 INFO - Running setup.py (path:/tmp/pip-y57sJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:01 INFO - Running setup.py (path:/tmp/pip-0mrTXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:01 INFO - Running setup.py (path:/tmp/pip-C22PG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:01 INFO - Running setup.py (path:/tmp/pip-IXNjLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:01 INFO - Running setup.py (path:/tmp/pip-liPSat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:01 INFO - Running setup.py (path:/tmp/pip-PqnRHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:01 INFO - Running setup.py install for manifestparser 08:40:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:40:01 INFO - Running setup.py install for mozcrash 08:40:02 INFO - Running setup.py install for mozdebug 08:40:02 INFO - Running setup.py install for mozdevice 08:40:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for mozfile 08:40:02 INFO - Running setup.py install for mozhttpd 08:40:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for mozinfo 08:40:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for mozInstall 08:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for mozleak 08:40:02 INFO - Running setup.py install for mozlog 08:40:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for moznetwork 08:40:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:40:02 INFO - Running setup.py install for mozprocess 08:40:03 INFO - Running setup.py install for mozprofile 08:40:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:40:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:40:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:40:03 INFO - Running setup.py install for mozrunner 08:40:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:40:03 INFO - Running setup.py install for mozscreenshot 08:40:03 INFO - Running setup.py install for moztest 08:40:03 INFO - Running setup.py install for mozversion 08:40:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:03 INFO - Cleaning up... 08:40:03 INFO - Return code: 0 08:40:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08: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')]} 08:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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', '-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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08: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', '-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 08: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 -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 08:40:03 INFO - Using env: {'DISPLAY': ':0', 08:40:03 INFO - 'HOME': '/home/cltbld', 08:40:03 INFO - 'LANG': 'en_US.UTF-8', 08:40:03 INFO - 'LANGUAGE': 'en_US:en', 08:40:03 INFO - 'LOGNAME': 'cltbld', 08:40:03 INFO - 'MAIL': '/var/mail/cltbld', 08:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:03 INFO - 'MOZ_NO_REMOTE': '1', 08:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:03 INFO - 'NO_EM_RESTART': '1', 08:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:03 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:03 INFO - 'SHELL': '/bin/bash', 08:40:03 INFO - 'SHLVL': '1', 08:40:03 INFO - 'TERM': 'linux', 08:40:03 INFO - 'TMOUT': '86400', 08:40:03 INFO - 'USER': 'cltbld', 08:40:03 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:03 INFO - '_': '/tools/buildbot/bin/python'} 08:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:03 INFO - Running setup.py (path:/tmp/pip-AfijYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:40:03 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)) 08:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:03 INFO - Running setup.py (path:/tmp/pip-0VLeP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:40:03 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)) 08:40:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:03 INFO - Running setup.py (path:/tmp/pip-HQuumV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:04 INFO - Running setup.py (path:/tmp/pip-wovCc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:04 INFO - Running setup.py (path:/tmp/pip-wiJsik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:04 INFO - Running setup.py (path:/tmp/pip-heffIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:04 INFO - Running setup.py (path:/tmp/pip-8b2A4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:04 INFO - Running setup.py (path:/tmp/pip-6rPDYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:04 INFO - Running setup.py (path:/tmp/pip-lc3Y8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:04 INFO - Running setup.py (path:/tmp/pip-wrNbLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:04 INFO - Running setup.py (path:/tmp/pip-BshdI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:04 INFO - Running setup.py (path:/tmp/pip-xgedbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:04 INFO - Running setup.py (path:/tmp/pip-QMKZUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:04 INFO - Running setup.py (path:/tmp/pip-Zw809h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:04 INFO - Running setup.py (path:/tmp/pip-l5Rhrd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:40:04 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)) 08:40:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:04 INFO - Running setup.py (path:/tmp/pip-KqELFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:40:05 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)) 08:40:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:05 INFO - Running setup.py (path:/tmp/pip-KqCHEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:40:05 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)) 08:40:05 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)) 08:40:05 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)) 08:40:05 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)) 08:40:05 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)) 08:40:05 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)) 08:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08: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 08: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 08: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 08: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 08: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 08: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 08:40:06 INFO - Downloading blessings-1.5.1.tar.gz 08:40:06 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 08:40:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:06 INFO - Installing collected packages: blessings 08:40:06 INFO - Running setup.py install for blessings 08:40:06 INFO - Successfully installed blessings 08:40:06 INFO - Cleaning up... 08:40:07 INFO - Return code: 0 08:40:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:40:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:40:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:40:07 INFO - Reading from file tmpfile_stdout 08:40:07 INFO - Current package versions: 08:40:07 INFO - argparse == 1.2.1 08:40:07 INFO - blessings == 1.5.1 08:40:07 INFO - blobuploader == 1.2.4 08:40:07 INFO - docopt == 0.6.1 08:40:07 INFO - manifestparser == 1.1 08:40:07 INFO - mozInstall == 1.12 08:40:07 INFO - mozcrash == 0.16 08:40:07 INFO - mozdebug == 0.1 08:40:07 INFO - mozdevice == 0.47 08:40:07 INFO - mozfile == 1.2 08:40:07 INFO - mozhttpd == 0.7 08:40:07 INFO - mozinfo == 0.9 08:40:07 INFO - mozleak == 0.1 08:40:07 INFO - mozlog == 3.1 08:40:07 INFO - moznetwork == 0.27 08:40:07 INFO - mozprocess == 0.22 08:40:07 INFO - mozprofile == 0.27 08:40:07 INFO - mozrunner == 6.11 08:40:07 INFO - mozscreenshot == 0.1 08:40:07 INFO - mozsystemmonitor == 0.0 08:40:07 INFO - moztest == 0.7 08:40:07 INFO - mozversion == 1.4 08:40:07 INFO - psutil == 3.1.1 08:40:07 INFO - requests == 1.2.3 08:40:07 INFO - wsgiref == 0.1.2 08:40:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:07 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:40:07 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 08:40:07 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 08:40:07 INFO - Using env: {'DISPLAY': ':0', 08:40:07 INFO - 'HOME': '/home/cltbld', 08:40:07 INFO - 'LANG': 'en_US.UTF-8', 08:40:07 INFO - 'LANGUAGE': 'en_US:en', 08:40:07 INFO - 'LOGNAME': 'cltbld', 08:40:07 INFO - 'MAIL': '/var/mail/cltbld', 08:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:07 INFO - 'MOZ_NO_REMOTE': '1', 08:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:07 INFO - 'NO_EM_RESTART': '1', 08:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:07 INFO - 'SHELL': '/bin/bash', 08:40:07 INFO - 'SHLVL': '1', 08:40:07 INFO - 'TERM': 'linux', 08:40:07 INFO - 'TMOUT': '86400', 08:40:07 INFO - 'USER': 'cltbld', 08:40:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:07 INFO - '_': '/tools/buildbot/bin/python'} 08:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 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)) 08:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:40:07 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)) 08:40:07 INFO - Cleaning up... 08:40:07 INFO - Return code: 0 08:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:07 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:40:07 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 08:40:07 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 08:40:07 INFO - Using env: {'DISPLAY': ':0', 08:40:07 INFO - 'HOME': '/home/cltbld', 08:40:07 INFO - 'LANG': 'en_US.UTF-8', 08:40:07 INFO - 'LANGUAGE': 'en_US:en', 08:40:07 INFO - 'LOGNAME': 'cltbld', 08:40:07 INFO - 'MAIL': '/var/mail/cltbld', 08:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:07 INFO - 'MOZ_NO_REMOTE': '1', 08:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:07 INFO - 'NO_EM_RESTART': '1', 08:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:07 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:07 INFO - 'SHELL': '/bin/bash', 08:40:07 INFO - 'SHLVL': '1', 08:40:07 INFO - 'TERM': 'linux', 08:40:07 INFO - 'TMOUT': '86400', 08:40:07 INFO - 'USER': 'cltbld', 08:40:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:07 INFO - '_': '/tools/buildbot/bin/python'} 08:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:07 INFO - Downloading/unpacking jsonschema 08:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:09 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 08:40:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:40:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:09 INFO - warning: no files found matching '*.txt' 08:40:09 INFO - no previously-included directories found matching 'build' 08:40:09 INFO - no previously-included directories found matching 'dist' 08:40:09 INFO - no previously-included directories found matching '.git*' 08:40:09 INFO - Installing collected packages: jsonschema, functools32 08:40:09 INFO - Running setup.py install for functools32 08:40:09 INFO - warning: no files found matching '*.txt' 08:40:09 INFO - no previously-included directories found matching 'build' 08:40:09 INFO - no previously-included directories found matching 'dist' 08:40:09 INFO - no previously-included directories found matching '.git*' 08:40:09 INFO - Successfully installed jsonschema functools32 08:40:09 INFO - Cleaning up... 08:40:09 INFO - Return code: 0 08:40:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:09 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 0x7fd2aef76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2af6450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, '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': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', '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 08:40:09 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 08:40:09 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 08:40:09 INFO - Using env: {'DISPLAY': ':0', 08:40:09 INFO - 'HOME': '/home/cltbld', 08:40:09 INFO - 'LANG': 'en_US.UTF-8', 08:40:09 INFO - 'LANGUAGE': 'en_US:en', 08:40:09 INFO - 'LOGNAME': 'cltbld', 08:40:09 INFO - 'MAIL': '/var/mail/cltbld', 08:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:09 INFO - 'MOZ_NO_REMOTE': '1', 08:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:09 INFO - 'NO_EM_RESTART': '1', 08:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:09 INFO - 'SHELL': '/bin/bash', 08:40:09 INFO - 'SHLVL': '1', 08:40:09 INFO - 'TERM': 'linux', 08:40:09 INFO - 'TMOUT': '86400', 08:40:09 INFO - 'USER': 'cltbld', 08:40:09 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:09 INFO - '_': '/tools/buildbot/bin/python'} 08:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:10 INFO - Downloading/unpacking flake8 08:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:40:11 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 08:40:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:40:11 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 08:40:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:12 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 08:40:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:40:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:12 INFO - no previously-included directories found matching 'docs/_build' 08:40:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:40:12 INFO - Running setup.py install for pep8 08:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:40:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:40:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:40:12 INFO - no previously-included directories found matching 'docs/_build' 08:40:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:40:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:40:12 INFO - Cleaning up... 08:40:12 INFO - Return code: 0 08:40:12 INFO - Running post-action listener: _resource_record_post_action 08:40:12 INFO - Running post-action listener: _start_resource_monitoring 08:40:12 INFO - Starting resource monitoring. 08:40:12 INFO - ##### 08:40:12 INFO - ##### Running install step. 08:40:12 INFO - ##### 08:40:12 INFO - Running pre-action listener: _resource_record_pre_action 08:40:12 INFO - Running main action method: install 08:40:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:40:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:40:12 INFO - Reading from file tmpfile_stdout 08:40:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:40:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:40:12 INFO - Reading from file tmpfile_stdout 08:40:12 INFO - Output received: 08:40:12 INFO - Usage: mozinstall [options] installer 08:40:12 INFO - Options: 08:40:12 INFO - -h, --help show this help message and exit 08:40:12 INFO - -d DEST, --destination=DEST 08:40:12 INFO - Directory to install application into. [default: 08:40:12 INFO - "/builds/slave/test-pgo"] 08:40:12 INFO - --app=APP Application being installed. [default: firefox] 08:40:12 INFO - mkdir: /builds/slave/test-pgo/build/application 08:40:12 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'] 08:40:12 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 08:40:27 INFO - Reading from file tmpfile_stdout 08:40:27 INFO - Output received: 08:40:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:40:27 INFO - Running post-action listener: _resource_record_post_action 08:40:27 INFO - ##### 08:40:27 INFO - ##### Running run-tests step. 08:40:27 INFO - ##### 08:40:27 INFO - Running pre-action listener: _resource_record_pre_action 08:40:27 INFO - Running main action method: run_tests 08:40:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:40:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:40:27 INFO - Python 2.7.3 08:40:27 INFO - Return code: 0 08:40:27 INFO - grabbing minidump binary from tooltool 08:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:27 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 0x2b88a50>, '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 0x2af4550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af49e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:40:27 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 08:40:27 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 08:40:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:27 INFO - Return code: 0 08:40:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:40:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:40:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:40:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:40:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:40:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:40:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:40:28 INFO - Return code: 0 08:40:28 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/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:40:28 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/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 08:40:28 INFO - Using env: {'DISPLAY': ':0', 08:40:28 INFO - 'HOME': '/home/cltbld', 08:40:28 INFO - 'LANG': 'en_US.UTF-8', 08:40:28 INFO - 'LANGUAGE': 'en_US:en', 08:40:28 INFO - 'LOGNAME': 'cltbld', 08:40:28 INFO - 'MAIL': '/var/mail/cltbld', 08:40:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:40:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:28 INFO - 'MOZ_NO_REMOTE': '1', 08:40:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:28 INFO - 'NO_EM_RESTART': '1', 08:40:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:40:28 INFO - 'PWD': '/builds/slave/test-pgo', 08:40:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:40:28 INFO - 'SHELL': '/bin/bash', 08:40:28 INFO - 'SHLVL': '1', 08:40:28 INFO - 'TERM': 'linux', 08:40:28 INFO - 'TMOUT': '86400', 08:40:28 INFO - 'USER': 'cltbld', 08:40:28 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775', 08:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:28 INFO - '_': '/tools/buildbot/bin/python'} 08:40:28 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/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 08:40:28 INFO - mozversion INFO | application_buildid: 20151230055836 08:40:28 INFO - mozversion INFO | application_changeset: 3c125ce5d3b1ec5367d9f788f6096b085a04a72a 08:40:28 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:40:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:28 INFO - mozversion INFO | application_name: Firefox 08:40:28 INFO - mozversion INFO | application_remotingname: firefox-dev 08:40:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:40:28 INFO - mozversion INFO | application_vendor: Mozilla 08:40:28 INFO - mozversion INFO | application_version: 45.0a2 08:40:28 INFO - mozversion INFO | platform_buildid: 20151230055836 08:40:28 INFO - mozversion INFO | platform_changeset: 3c125ce5d3b1ec5367d9f788f6096b085a04a72a 08:40:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:40:28 INFO - mozversion INFO | platform_version: 45.0a2 08:40:28 INFO - 2015-12-30 08:40:28,703 DEBUG : using testdate: 1451493628 08:40:28 INFO - 2015-12-30 08:40:28,703 DEBUG : actual date: 1451493628 08:40:28 INFO - 2015-12-30 08:40:28,755 INFO : starting webserver on 'localhost:47306' 08:40:28 INFO - 2015-12-30 08:40:28,756 INFO : Starting test suite talos-linux64-ix-047.e 08:40:28 INFO - 2015-12-30 08:40:28,756 INFO : Starting test dromaeo_css 08:40:28 INFO - 2015-12-30 08:40:28,756 DEBUG : operating with platform_type : linux_ 08:40:28 INFO - 2015-12-30 08:40:28,757 INFO : Initialising browser for dromaeo_css test... 08:40:28 INFO - 2015-12-30 08:40:28,771 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgGftC5/profile http://localhost:47306/getInfo.html 08:40:33 INFO - 2015-12-30 08:40:33,081 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:40:33 INFO - 2015-12-30 08:40:33,082 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:40:33 INFO - 2015-12-30 08:40:33,082 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:40:33 INFO - 2015-12-30 08:40:33,082 DEBUG : BROWSER_OUTPUT: __metrics 08:40:34 INFO - 2015-12-30 08:40:34,053 INFO : Browser initialized. 08:40:34 INFO - 2015-12-30 08:40:34,054 INFO : Running cycle 1/1 for dromaeo_css test... 08:40:34 INFO - 2015-12-30 08:40:34,054 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgGftC5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:40:45 INFO - 2015-12-30 08:40:45,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 136736768 08:40:45 INFO - 2015-12-30 08:40:45,815 DEBUG : BROWSER_OUTPUT: 08:41:35 INFO - 2015-12-30 08:41:35,425 DEBUG : BROWSER_OUTPUT: 1451493695424 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] 08:43:43 INFO - 2015-12-30 08:43:43,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47306/tests/dromaeo/cssquery-ext.html) 08:43:44 INFO - 2015-12-30 08:43:44,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 142577664 08:43:44 INFO - 2015-12-30 08:43:44,196 DEBUG : BROWSER_OUTPUT: 08:46:46 INFO - 2015-12-30 08:46:46,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-ext.html (next: http://localhost:47306/tests/dromaeo/cssquery-jquery.html) 08:46:46 INFO - 2015-12-30 08:46:46,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 139063296 08:46:46 INFO - 2015-12-30 08:46:46,629 DEBUG : BROWSER_OUTPUT: 08:49:48 INFO - 2015-12-30 08:49:48,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47306/tests/dromaeo/cssquery-mootools.html) 08:49:48 INFO - 2015-12-30 08:49:48,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 138567680 08:49:48 INFO - 2015-12-30 08:49:48,794 DEBUG : BROWSER_OUTPUT: 08:52:50 INFO - 2015-12-30 08:52:50,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47306/tests/dromaeo/cssquery-prototype.html) 08:52:50 INFO - 2015-12-30 08:52:50,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 140288000 08:52:50 INFO - 2015-12-30 08:52:50,936 DEBUG : BROWSER_OUTPUT: 08:55:53 INFO - 2015-12-30 08:55:53,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47306/tests/dromaeo/cssquery-yui.html) 08:55:53 INFO - 2015-12-30 08:55:53,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 08:55:53 INFO - 2015-12-30 08:55:53,796 DEBUG : BROWSER_OUTPUT: 08:58:55 INFO - 2015-12-30 08:58:55,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/dromaeo/cssquery-yui.html (next: http://localhost:47306/tests/dromaeo/cssquery-dojo.html) 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 142102528 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3284.5565848610436;3294.8187849668275;3297.670232976704;3324.983375083125;3326.4677651575753;5266.631335806495;5277;5282.418933917266;5284.471552844713;5292.311999440077;5250.4487028861895;5296.232046353276;5297.602679799021;5299.33758280215;5302.708351040691;4826.083044221596;4857.878553036167;4888.486708895568;4897.04507621014;4922.360093187881;4816.686915350509;4877.292792545079;4950.9257361139435;4953.281774142747;4987.027529631723;4846.466888642264;4900.607951363901;4916.606671466274;4920.68015578988;5003.324551185579;4983.875403114915;4992.950070499285;4994.725290109042;5018.5232402921665;5040.899182016357;4707.364505791708;4741.57325840676;4810.4467986181335;4936.3829521309835;4944.431390390079;5113.181890897476;5136.43499215086;5153.793848246066;5162.535371816554;5163.63854530183;5736.827895163152;5757.82726518201;5767.971160144214;5772.251896404684;5790.507806836424;5607.102863541813;5644.435556444364;5802.303723553158;5810.157527158581;5933.19901813254;5467;5486.149646804752;5487.149491828773;5495.175723641446;5503.477169668875;5924.052151655715;5928.555358348141;5928.733207005609;5932.703364831741;5939;5493.752781124859;5609.6353737007785;5647.463490968352;5716.085426331767;5751.769929202868;5778.422157784272;5820.854478637983;5853.678047707332;5860.355360910296;5874.060150375919;5567.610267281251;5803.274590676166;5815.854603634943;5818.44724751148;5819.447152520504;5636.210930469738;5638.9436105638415;5698.031334673115;5700.828975130753;5724.370319264877;4451.844185453494;4463.174312752151;4478.820847166142;4502.684812063189;4513.977430112828;3918.52977642679;3993.3610622300293;4034.152827906114;4049.6152865477734;4081.7346872453195;5444.183372494078;5444.7822087116865;5460.453954604587;5463.672179669233;5495.945040549624;5805.303363596396;5836.095405212199;5842.503387212135;5844.152597873284;5848.064309710426;5447.53695935842;5486.91769623456;5553.583481238923;5592.972035139798;5622;4921.434035085939;4939.135651261086;4939.185034469344;4946.258061290835;4949.282354058713;5981.730822113015;5984.1921340618455;5999.580029397987;5999.880002400015;6027.60820546663;5568.526675232651;5648.774049037993;5700.173474846207;5809.0415081512765;5860.120981852756;5908.261467316585;5917.112433135064;5918.053111502139;5923.911141332969;5994;5711.314642242957;5716.42835716425;5722.055860782924;5723.885522289447;5737.282839645044;5556.777728890799;5623.493885550157;5697.829065128053;5776.480116789509;5800.158976948234;5671.8865622688145;5681.346645135863;5705.486506214461;5705.885882282414;5706.029974904359;5406.567474601944;5650.519705825051;5681.0626246668835;5696.316442026983;5703.144528320785;5523.7238138093735;5544.916826247529;5551.8889622206525;5577.6653400796085;5595.132754423071;5691.800786972436;5719.628224165416;5767.336756273083;5770.740316685676;5784.5083167929515;5401.027814993182;5492.0663487206475;5587.860303492445;5637.746301416528;5671.0359238930305 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.9122835960426;568.1789813719175;569.2684899903625;585.7159277750293;593.2613895699855;40360;41131.794341028326;41330.17339653205;41430.17139657205;41443.58556414435;46395.53604463954;46994.53005469944;47007.29489057667;47083;47096.764516177456;9209.125133112344;9327.860082098774;9348.766280842965;9361.344705870591;9408.388454750419;9048.276137908952;9057.773555661095;9066.909330906705;9127.406718563305;9134.680286189985;6838.589684618914;6908.309169083077;6910.481713871454;6922.06552115463;7037.190723066861;9100.08999100088;9210.67762628308;9217.539123043854;9220.354575179741;9223.67717129904;8922.241609463203;9104.590293436744;9120;9123.498207598579;9138.54307284633;43570.56429435697;44121.11757764859;44169.55830441687;44220.778896105636;44245.336319955226;3106.6116735408073;3669.9633003669887;3723.2181241938956;3785.337565925952;4011.859584914514;30765.077047688606;31033.22416939572;31096.067117986495;31423;31746.206344841332;3752.5496940367057;3796.4495148203355;3821.8662346817728;3875.6318149775725;3884.883453496371;252526;254767;255123;255426;255957;44152.11695766067;44297.33553996692;44584.55415445869;44589.33116003263;59834;41953.580464194965;42157.78921105375;42186;42197;42218.78890605527;15724.213789310488;16314.67370652604;16352.591185220464;16420.83579164217;16431.91784041096;12404.441800119017;12496.81254781179;12527.812082818766;12549.937250313873;12609.180403273758;14909.850901491063;15141.394344226108;15141.621459463602;15162.848371516144;15196.772048419283;6004.519638428916;6109.678322237522;6142.754289828446;6184.165137706442;6198.411150940744;977.1108291454742;1038.4496217004998;1057.814882395593;1118.6028959719345;1152.8241193982092;29857.85071074631;29963.550546741815;30022.699773002427;30493.542596861065;30810;1098.1050443888205;1134.393099691661;1148.1446322489633;1157.548556063136;1165.81929800881;17213.655726885394;17459.47621571355;17702.645947080986;17819.10904454772;17944.013079280765;446686;585869;586628;878926;905603.9439605651;62399.376006240265;62861.37138628647;63457;63604.36395635984;63643;1560.7346751052576;1571.4814111343458;1576.1252504859683;1576.7950166478283;1588.1424031023118;31757.364852702354;32138.19654508656;32547.51178732368;33178.5023224647;36327;54596;55440.445595543526;55744.16383754328;55813.16280255881;55979.72010139923;338194;338424;338732;340885;341131;46482.767586161855;46873.76563117163;46962.76518617522;47450.52549474599;47557.524424756695;50983.745081274355;51271.74364128305;51655.74172129115;51670.22494662508;51794;43259.134817304104;43652.781736091114;44196.779016104716;44593.33110003417;45187.32219016783;41847.37228941507;41875.371869421375;42198.367024494044;42673;42981.14037719165;41072.79463602663;41266.38100428436;41327.58672413237;41462.79268603637;41609.79195104126;37103;37147;37267.44098838574;37335.25329493449;38189.2362152761;28477;28831.711682882902;28867.711322886502;29145.7085429143;29327.560086599144 08:58:56 INFO - 2015-12-30 08:58:56,207 DEBUG : BROWSER_OUTPUT: |2;jquery.html;366.7377824855228;368.15692065170776;369.7079307347196;370.42029224264024;372.1180801500444;17631.64736705267;18324.725129123057;18719.438416847483;19103.71344429831;19738;11536.01943834773;11552;11568.942155289213;11619.535218591247;11860.881391186085;5078.289039534468;5095.082885080693;5228.581713462933;5241.42344342122;5252.8161514347;5120.820771273006;5121.769520371592;5147.279380886679;5150.815312478132;5172.560332371734;5191.351081114861;5208.765605547759;5237.240600112981;6563.1796025496815;6767.154105736783;6726.260111387744;6763.8309042274095;6781.694823732919;6819.659017049153;7082.858342833166;6867.313268673142;6886.69009894556;6894.034835123037;6901.895696688506;6914.032035515032;24373.756262437328;24459.755402446102;24626.138085167113;25122.748772512405;26104.60843087355;2370.0401337458356;2387.5224955008894;2398.304491697406;2473.406382468195;2574;15563;15966.521004369888;15989.360425582963;16381;16402.425915093034;1904.5905130396893;1972.80271972803;2139.5613899150635;2210.2153735424013;2263.7283525976986;71194.64402678005;71602.64198678973;76195;78440;78626.60686696644;16669.91665041667;16766.74849877253;16802.915985419993;16817.159142043092;16917.661646766996;26192.73807261903;26298.86850565773;26383.34041648974;26458.470830583665;26571.335716606853;9758.75603109928;9826.06652368024;9853.753656158653;9873.308868379288;9980.351277166961;8545.359098067669;8584.356173287028;8586.398952073296;8592.914070859337;8596.484210947363;8318.792030199293;8322.126176751353;8328;8344.707935222237;8358.45670031446;1878.6900161473477;3102.705243001911;3190.883190883219;3263.368315842079;3304.140923359944;914.7850255190025;957.683964291796;1000.9149222316184;1001.4191768774093;1013.0882206014498;15048.774268385983;16253.780966427565;16613.83386166147;17435.825641743675;18101.09494525295;938.7090002099371;945.3571571331561;1055.767731099157;1089.782043591269;1099.1591432554103;9737.56180971858;9814.214862810957;9815.558299876522;9836.06557377048;9847.50762461874;551583;563122;643791;655581;681796;84849.57575212084;85949.14050859536;86783;86834.56582717046;87382;1249.3316075899531;1260.7730608490376;1272.662744372742;1277.0166971431945;1289.6582405662318;15081.849181508484;15134.697306054037;15252.618684532532;15627;15723.528294151194;33156.66843331536;33171.50242746409;33798.15504612404;34496.13759655928;34618;49615;50230.246546302566;51496;54052.48803684246;54614;9920.107190352903;10022.799544008933;10051.899481005097;10082.69751907444;10146.340487868265;12103;12213.938930305292;12218.633440996784;15189.240537973279;18460.81539184591;13810.65473363174;15045.699086018438;15332.693346132792;15529.301181447088;15605;15096.39614415411;15134.016288941184;15281;15859.920700396424;15920.124393158487;16149.273282702072;16171.191440428167;16207.594810129369;16319.836801632307;16449.25978330954;10041.196704263788;10196.4391958443;10247.538860751136;10326.380417174994;10349.63776267827;15314.846851531342;15364.692706145592;15656.686866262839;15736.370545178064;16127.274272657523 08:58:56 INFO - 2015-12-30 08:58:56,209 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.632648164441;1541.8843586730998;1742.1115231232068;1801.2617823800033;1834.5597056706395;6338.683065846701;6591.5715478493985;7160.964195179024;7378.299061589147;7393.482456228066;7330.816729581763;7447.106347238339;7493.887591686129;7501.137369202544;7521.398288136949;2260.5930932432157;2297.689811875392;2302.044651469638;2305.400595845084;2306.4579823741406;2274.749777524471;2303.79265866072;2318.5131122464304;2319.536092781442;2320.431494283903;2259.6610508423787;2280.407094155515;2314.4213946513373;2329.6389059695775;2330.463993281546;2258.2209137847417;2269.2965180793926;2291.106468477295;2295.024614538823;2300.6894069300683;2323.581755284048;2337.8012868905994;2340.8010319122895;2344.2732752846673;2349.765023497637;7540.396768258581;7612.80967975805;7618.200088990631;7622.428317876182;7660.348870346027;4677.6491763117565;4698.812047518095;4722.976385118087;4744.051189762027;4746.21687421575;3039.9392012159633;3040.452718510667;3091.6444608870042;3094;3118.4854499007865;975.2831668723483;994.6916455898695;1005.1857995024054;1025.6871654145482;1031.2265800649513;10138.442385668784;10156.644517441853;10162.59349626014;10166.13587845034;10174.694759157162;4228.1966426378885;4316.43886294786;4317.438732964694;4319.546447623017;4346.913061738811;8817.691380801769;8820.470771753715;8827.249683776823;8830.823383532423;8831.514266715392;4807.78364973577;4809.711417314972;4815.566599006106;4824.300476430968;4826.61387089032;4222.619964203175;4247.5540068293;4365.476142862877;4452.532484089189;4466.7766611669285;3403.829808509565;3414.0440676610588;3442.862285508602;3448.103493091814;3453;1020.4846552490944;1021.0657248617432;1030.5156576409076;1030.922680798943;1054.2356791326226;1197.9820302695466;1217.0385395537426;1217.4764851113928;1229.6188181663713;1232.4946771823509;7241.52930059555;7255.637218139177;7265.2371500992695;7282.927170728225;7461.253874612496;1136.3068528197794;1149.40231079838;1161.5528021711532;1193.4127610278483;1196.2822306616135;5741.25363702716;5796.971015144982;5811.535077193815;5822.883542329215;5831.504322132666;8554.01628812682;8949.284057275403;9044.819103618023;9116.4074335168;9235.492047937294;8888.155625215593;8901.688440904538;8921.063288354759;9050.818983620291;9055.773605659911;7093.184283807325;7141.714331426685;7261.636918154071;7269.164046134762;7345.77962661121;6695.12963314766;6702.865942681022;6728.966355168192;6733.966330168318;6753.189617245962;7881.842363152819;8106.351491880518;8190.180981902001;8335.833283334421;8363.916360836558;8161.347092232726;8269.751907442786;8296.626651800803;8404.159584041547;8488.915110848813;5918.526517878646;6050.364711705383;6558.1802274715665;6575.375339342755;6706.66466676674;7051.294870512907;7053.400460960671;7073.115860517435;7084.397826184832;7105.964470177616;6897.93102068993;7056.788296351117;7058.435325174077;7111.60886151246;7157.1769246537315;6588.505862060269;6702.162229721285;6712.160979877515;6767.729290828312;6862.382385585322;6819;6947.5831450113155;6956.5478243913985;6958.686859091252;7001.649917504206;6298.338674439301;6334.619922804646;6350.968245158745;6354;6357.268914074941;6463.385978332051;6466.644334561644;6496.0580715795;6504.479641628753;6506.967465162644 08:58:56 INFO - 2015-12-30 08:58:56,209 DEBUG : BROWSER_OUTPUT: |4;prototype.html;326.2512533735078;330.9536664866918;339.2637975592964;352.9135361836351;359.3764818040699;6338.936610633892;6342.556021078521;6355.332690067546;6432.871342573146;6521.673916304189;6350.237971443434;6353.332900045487;6362.681865906709;6390.073439351291;6391.616503009823;4829.492903245161;4844.539768721966;4844.87887802806;4847.127517046939;4848.97575512122;4863.076015557051;4863.294822250771;4863.513648635144;4866.416030076396;4878.243872199797;4677.579017888389;4698.036902434993;4775.856724298276;4795.688280261772;4805.351277577534;4761.047790441926;4767.547083027107;4786.234202527578;4796.52034796521;4799.712017278957;4179.373094035888;4179.937300940488;4186.958130418688;4188.183304255671;4195.517515485728;5975.462208401264;5988.520918326523;5995.2206213192;6007.819765407001;6013.368596297413;5525.861853453655;5597.972010139923;5609.242752228479;5616;5617.466340697627;6665.266820649725;6705.430038446689;6706.429953453962;6711.463082953352;6718.966405167992;4632.119897219518;4637.188492013918;4643.512431194744;4651.8835479485015;4655.604273636745;6748.987651852212;6854.485913556503;6911.3779759821855;6963.373296403297;6968.756093536702;4733.834315798999;4737.431508219036;4742.407199100113;4746.38297021385;4748.525147485293;4793.400824896888;4808.567228949341;4815.855524334275;4815.975920120377;4822.95177048232;5572.498475137176;5582.832515024475;5586.217929489874;5591.552675786009;5601.383847776741;6586.934130658728;6759.121314229119;6804.727810887509;6805.727770889109;6838.418734407631;1673.6067024249292;1688.0546893739545;1690.7294832826935;1691.323470611765;1696.2706036404466;1126.1553834624033;1126.5437497813398;1133.4389477208833;1136.3522792008475;1153.066016526616;6518.054882042172;6577.046328282468;6585.209774827052;6585.440237579859;6601.603903765789;6895.448364130958;6946.548474349152;6960.895586566206;6967.477439191979;6977.33715297046;6503.512236582275;6508.8047358579315;6570.934290657032;6582.144321238304;6592.604443733296;3783.9243215135543;3799.3920972644246;3816.8282427290283;3835.6356146166067;3839.8080095995088;7282.235365286675;7289.817754556178;7295.343419092307;7297.854042919112;7306.415486761046;7079.752208672672;7176.96411517939;7241.42068634508;7242.855142897112;7254.818629534198;7257.237990011078;7257.782266532013;7261.491695581259;7268.055152830204;7300.598467084255;6959.930400695928;6986.6855991481525;7005.54463959841;7015.824604384931;7019.3682568569075;6733.326667333227;6908.516403851682;6914.101166848278;6953.582785032914;6996;7246.384057355184;7269.200387957215;7271.2365201653065;7283.089613798275;7283.526570772883;4819.542143496362;4888.755562221803;4889.535494128052;4904.779284932258;4915.7542122893;6801.693923773343;6935.514513984174;6948.687309071205;6948.826279343057;6953.748325301494;6793.252742198255;6798.52410331272;6818.215905170969;6818.693158807965;6823.965880170567;6670.266270710315;6739.966300168468;6782.118324617965;6782.525223234524;6789.2192397872905;6693.230278517838;6696.263411024686;6698.631575263407;6701.497387695845;6706.094677218708;6902.896456553055;6913.9974703668695;6918.5502942308585;6923.376896079377;6923.411510021503;6640.601563906181;6707.5975441473665;6737.124173857367;6742.359475849787;6750.6624668767345 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: |5;yui.html;803.5459965119707;809.4900212865894;878.113105763179;921.5438358012784;952.1763674421625;13313.53402630908;13427.93286033571;13449.932750336247;13456.461741530327;13498.257595832225;12649.683757906058;12753.489860405572;12773;12787.552435664753;12808.93595532021;738.5347231244309;749.2769477454256;891.3003292415423;903.3541018172006;904.9049849765779;898.9775255618629;902.7923577577161;908.2007833106857;910.8497097978826;910.899801021887;939.037486576258;946.1201082992814;951.7002144324516;952.7141857442774;954.3653470442148;936.5036530638738;939.8120375924774;940.275987489636;941.444547716847;944.4144630329206;698.4726531468759;700.9509334346598;701.6281370873445;702.6556987076347;705.4990956420947;12895.09734318598;12969.935150324281;12988.090833641649;12989.285589292585;13059.542915997894;12763.808542871864;12823;12871.09902306839;12967.675808104872;13466.487802454434;10955.671329860117;11122.165837562134;11278.661640150809;11326.26379285352;11346.546138154465;3817.9045523861846;3832.156925476391;3841.7310788244836;3885.2812229737588;3897.4933258676474;51018.48981510212;51059;51096.744516277555;51418.228726568756;51675.483245167445;10433.895661043443;11009.83485247722;11335.376554289593;11382.772344553228;11475.483603237873;18347.17437715306;18355.35756248525;18565;18588.721169182474;18688.719669204973;7378.852422951511;7421.591812450259;7423.665935032828;7454.85090298191;7511.9624401877645;4571.131485017836;4611.584957353787;4643.74459404736;4666.766661666903;4672.976635116871;3113.8910138145056;3146.11908665574;3157.163351711798;3160.336329370812;3162.667919868427;560.529155509366;571.2687759667632;574.9425057494217;580.9796657116981;585.2625691628579;704.6688056613383;707.1372925031453;714.3035540348119;718.7448455798117;741.7366834773685;8475.57622118904;10184.898151018544;10194.674692290104;10380.480975951172;10515.05364517197;593.9584229103921;756.5990025286607;759.8290384663406;764.7820371194183;772.5441989226271;3652.251288485854;3846.9230615387537;3971.0866500705;4027.275090483741;4029.476168098187;55731;56322.718386408626;56410.43589564134;56475.71762141163;57784.133238001465;48736.51263487391;48893.51106488961;49112;49656.75171624191;49804.01175929456;46471.5352846474;46874;47135;47301.05397892023;47582.762086189345;9091.636334546543;9106.408083474553;9273.814523709623;9449.244060475008;9580.520973951136;34828.78099266615;35013.47479787856;35182;35332.64667353396;36067.81966090153;37770.244595108496;39517.60482395254;42968.570314296456;43748.34377484277;43798.56201437945;11195.048420884315;11320;11585.189036767346;11592.1305902056;11924.463399147233;12964.09251352434;13207.471701131846;13271;13828.930855346061;13911.304434778423;12190.390480475764;12423.37883105823;12457.12800103984;12472.251664900135;12732.299723515296;11917;12342.506299747909;12371.814422783485;12675.17611355259;12950.805737914126;12015.519379225083;12162.087843411602;12176.330301833485;12470.314132722788;12764.106512544033;10672.413017284123;10754.89245107539;10799.298045627009;10831.891681083089;10993.505292261707;10021.448820314661;10307.020833020852;10477.580896764044;10480.68557943263;10512.159027277647 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:58:56 INFO - 2015-12-30 08:58:56,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494736200__endTimestamp 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5362.36 Median:5568.53 stddev:584.26 (10.5%) stddev-sans-first:562.85 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: Values: 3284.6 3294.8 3297.7 3325.0 3326.5 5266.6 5277.0 5282.4 5284.5 5292.3 5250.4 5296.2 5297.6 5299.3 5302.7 4826.1 4857.9 4888.5 4897.0 4922.4 4816.7 4877.3 4950.9 4953.3 4987.0 4846.5 4900.6 4916.6 4920.7 5003.3 4983.9 4993.0 4994.7 5018.5 5040.9 4707.4 4741.6 4810.4 4936.4 4944.4 5113.2 5136.4 5153.8 5162.5 5163.6 5736.8 5757.8 5768.0 5772.3 5790.5 5607.1 5644.4 5802.3 5810.2 5933.2 5467.0 5486.1 5487.1 5495.2 5503.5 5924.1 5928.6 5928.7 5932.7 5939.0 5493.8 5609.6 5647.5 5716.1 5751.8 5778.4 5820.9 5853.7 5860.4 5874.1 5567.6 5803.3 5815.9 5818.4 5819.4 5636.2 5638.9 5698.0 5700.8 5724.4 4451.8 4463.2 4478.8 4502.7 4514.0 3918.5 3993.4 4034.2 4049.6 4081.7 5444.2 5444.8 5460.5 5463.7 5495.9 5805.3 5836.1 5842.5 5844.2 5848.1 5447.5 5486.9 5553.6 5593.0 5622.0 4921.4 4939.1 4939.2 4946.3 4949.3 5981.7 5984.2 5999.6 5999.9 6027.6 5568.5 5648.8 5700.2 5809.0 5860.1 5908.3 5917.1 5918.1 5923.9 5994.0 5711.3 5716.4 5722.1 5723.9 5737.3 5556.8 5623.5 5697.8 5776.5 5800.2 5671.9 5681.3 5705.5 5705.9 5706.0 5406.6 5650.5 5681.1 5696.3 5703.1 5523.7 5544.9 5551.9 5577.7 5595.1 5691.8 5719.6 5767.3 5770.7 5784.5 5401.0 5492.1 5587.9 5637.7 5671.0 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,211 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59052.39 Median:41914.48 stddev:127771.91 (304.8%) stddev-sans-first:128054.88 08:58:56 INFO - 2015-12-30 08:58:56,212 DEBUG : BROWSER_OUTPUT: Values: 565.9 568.2 569.3 585.7 593.3 40360.0 41131.8 41330.2 41430.2 41443.6 46395.5 46994.5 47007.3 47083.0 47096.8 9209.1 9327.9 9348.8 9361.3 9408.4 9048.3 9057.8 9066.9 9127.4 9134.7 6838.6 6908.3 6910.5 6922.1 7037.2 9100.1 9210.7 9217.5 9220.4 9223.7 8922.2 9104.6 9120.0 9123.5 9138.5 43570.6 44121.1 44169.6 44220.8 44245.3 3106.6 3670.0 3723.2 3785.3 4011.9 30765.1 31033.2 31096.1 31423.0 31746.2 3752.5 3796.4 3821.9 3875.6 3884.9 252526.0 254767.0 255123.0 255426.0 255957.0 44152.1 44297.3 44584.6 44589.3 59834.0 41953.6 42157.8 42186.0 42197.0 42218.8 15724.2 16314.7 16352.6 16420.8 16431.9 12404.4 12496.8 12527.8 12549.9 12609.2 14909.9 15141.4 15141.6 15162.8 15196.8 6004.5 6109.7 6142.8 6184.2 6198.4 977.1 1038.4 1057.8 1118.6 1152.8 29857.9 29963.6 30022.7 30493.5 30810.0 1098.1 1134.4 1148.1 1157.5 1165.8 17213.7 17459.5 17702.6 17819.1 17944.0 446686.0 585869.0 586628.0 878926.0 905603.9 62399.4 62861.4 63457.0 63604.4 63643.0 1560.7 1571.5 1576.1 1576.8 1588.1 31757.4 32138.2 32547.5 33178.5 36327.0 54596.0 55440.4 55744.2 55813.2 55979.7 338194.0 338424.0 338732.0 340885.0 341131.0 46482.8 46873.8 46962.8 47450.5 47557.5 50983.7 51271.7 51655.7 51670.2 51794.0 43259.1 43652.8 44196.8 44593.3 45187.3 41847.4 41875.4 42198.4 42673.0 42981.1 41072.8 41266.4 41327.6 41462.8 41609.8 37103.0 37147.0 37267.4 37335.3 38189.2 28477.0 28831.7 28867.7 29145.7 29327.6 08:58:56 INFO - 2015-12-30 08:58:56,212 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,213 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32984.67 Median:26148.67 stddev:101481.75 (388.1%) stddev-sans-first:101736.88 08:58:56 INFO - 2015-12-30 08:58:56,213 DEBUG : BROWSER_OUTPUT: Values: 366.7 368.2 369.7 370.4 372.1 17631.6 18324.7 18719.4 19103.7 19738.0 11536.0 11552.0 11568.9 11619.5 11860.9 5078.3 5095.1 5228.6 5241.4 5252.8 5120.8 5121.8 5147.3 5150.8 5172.6 5191.4 5208.8 5237.2 6563.2 6767.2 6726.3 6763.8 6781.7 6819.7 7082.9 6867.3 6886.7 6894.0 6901.9 6914.0 24373.8 24459.8 24626.1 25122.7 26104.6 2370.0 2387.5 2398.3 2473.4 2574.0 15563.0 15966.5 15989.4 16381.0 16402.4 1904.6 1972.8 2139.6 2210.2 2263.7 71194.6 71602.6 76195.0 78440.0 78626.6 16669.9 16766.7 16802.9 16817.2 16917.7 26192.7 26298.9 26383.3 26458.5 26571.3 9758.8 9826.1 9853.8 9873.3 9980.4 8545.4 8584.4 8586.4 8592.9 8596.5 8318.8 8322.1 8328.0 8344.7 8358.5 1878.7 3102.7 3190.9 3263.4 3304.1 914.8 957.7 1000.9 1001.4 1013.1 15048.8 16253.8 16613.8 17435.8 18101.1 938.7 945.4 1055.8 1089.8 1099.2 9737.6 9814.2 9815.6 9836.1 9847.5 551583.0 563122.0 643791.0 655581.0 681796.0 84849.6 85949.1 86783.0 86834.6 87382.0 1249.3 1260.8 1272.7 1277.0 1289.7 15081.8 15134.7 15252.6 15627.0 15723.5 33156.7 33171.5 33798.2 34496.1 34618.0 49615.0 50230.2 51496.0 54052.5 54614.0 9920.1 10022.8 10051.9 10082.7 10146.3 12103.0 12213.9 12218.6 15189.2 18460.8 13810.7 15045.7 15332.7 15529.3 15605.0 15096.4 15134.0 15281.0 15859.9 15920.1 16149.3 16171.2 16207.6 16319.8 16449.3 10041.2 10196.4 10247.5 10326.4 10349.6 15314.8 15364.7 15656.7 15736.4 16127.3 08:58:56 INFO - 2015-12-30 08:58:56,213 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,213 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5328.93 Median:6316.48 stddev:2681.13 (42.4%) stddev-sans-first:2673.45 08:58:56 INFO - 2015-12-30 08:58:56,214 DEBUG : BROWSER_OUTPUT: Values: 1530.6 1541.9 1742.1 1801.3 1834.6 6338.7 6591.6 7161.0 7378.3 7393.5 7330.8 7447.1 7493.9 7501.1 7521.4 2260.6 2297.7 2302.0 2305.4 2306.5 2274.7 2303.8 2318.5 2319.5 2320.4 2259.7 2280.4 2314.4 2329.6 2330.5 2258.2 2269.3 2291.1 2295.0 2300.7 2323.6 2337.8 2340.8 2344.3 2349.8 7540.4 7612.8 7618.2 7622.4 7660.3 4677.6 4698.8 4723.0 4744.1 4746.2 3039.9 3040.5 3091.6 3094.0 3118.5 975.3 994.7 1005.2 1025.7 1031.2 10138.4 10156.6 10162.6 10166.1 10174.7 4228.2 4316.4 4317.4 4319.5 4346.9 8817.7 8820.5 8827.2 8830.8 8831.5 4807.8 4809.7 4815.6 4824.3 4826.6 4222.6 4247.6 4365.5 4452.5 4466.8 3403.8 3414.0 3442.9 3448.1 3453.0 1020.5 1021.1 1030.5 1030.9 1054.2 1198.0 1217.0 1217.5 1229.6 1232.5 7241.5 7255.6 7265.2 7282.9 7461.3 1136.3 1149.4 1161.6 1193.4 1196.3 5741.3 5797.0 5811.5 5822.9 5831.5 8554.0 8949.3 9044.8 9116.4 9235.5 8888.2 8901.7 8921.1 9050.8 9055.8 7093.2 7141.7 7261.6 7269.2 7345.8 6695.1 6702.9 6729.0 6734.0 6753.2 7881.8 8106.4 8190.2 8335.8 8363.9 8161.3 8269.8 8296.6 8404.2 8488.9 5918.5 6050.4 6558.2 6575.4 6706.7 7051.3 7053.4 7073.1 7084.4 7106.0 6897.9 7056.8 7058.4 7111.6 7157.2 6588.5 6702.2 6712.2 6767.7 6862.4 6819.0 6947.6 6956.5 6958.7 7001.6 6298.3 6334.6 6351.0 6354.0 6357.3 6463.4 6466.6 6496.1 6504.5 6507.0 08:58:56 INFO - 2015-12-30 08:58:56,215 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,215 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5655.62 Median:6513.43 stddev:1720.29 (26.4%) stddev-sans-first:1677.97 08:58:56 INFO - 2015-12-30 08:58:56,215 DEBUG : BROWSER_OUTPUT: Values: 326.3 331.0 339.3 352.9 359.4 6338.9 6342.6 6355.3 6432.9 6521.7 6350.2 6353.3 6362.7 6390.1 6391.6 4829.5 4844.5 4844.9 4847.1 4849.0 4863.1 4863.3 4863.5 4866.4 4878.2 4677.6 4698.0 4775.9 4795.7 4805.4 4761.0 4767.5 4786.2 4796.5 4799.7 4179.4 4179.9 4187.0 4188.2 4195.5 5975.5 5988.5 5995.2 6007.8 6013.4 5525.9 5598.0 5609.2 5616.0 5617.5 6665.3 6705.4 6706.4 6711.5 6719.0 4632.1 4637.2 4643.5 4651.9 4655.6 6749.0 6854.5 6911.4 6963.4 6968.8 4733.8 4737.4 4742.4 4746.4 4748.5 4793.4 4808.6 4815.9 4816.0 4823.0 5572.5 5582.8 5586.2 5591.6 5601.4 6586.9 6759.1 6804.7 6805.7 6838.4 1673.6 1688.1 1690.7 1691.3 1696.3 1126.2 1126.5 1133.4 1136.4 1153.1 6518.1 6577.0 6585.2 6585.4 6601.6 6895.4 6946.5 6960.9 6967.5 6977.3 6503.5 6508.8 6570.9 6582.1 6592.6 3783.9 3799.4 3816.8 3835.6 3839.8 7282.2 7289.8 7295.3 7297.9 7306.4 7079.8 7177.0 7241.4 7242.9 7254.8 7257.2 7257.8 7261.5 7268.1 7300.6 6959.9 6986.7 7005.5 7015.8 7019.4 6733.3 6908.5 6914.1 6953.6 6996.0 7246.4 7269.2 7271.2 7283.1 7283.5 4819.5 4888.8 4889.5 4904.8 4915.8 6801.7 6935.5 6948.7 6948.8 6953.7 6793.3 6798.5 6818.2 6818.7 6824.0 6670.3 6740.0 6782.1 6782.5 6789.2 6693.2 6696.3 6698.6 6701.5 6706.1 6902.9 6914.0 6918.6 6923.4 6923.4 6640.6 6707.6 6737.1 6742.4 6750.7 08:58:56 INFO - 2015-12-30 08:58:56,215 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,215 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14076.56 Median:3891.39 stddev:15759.81 (405.0%) stddev-sans-first:15772.50 08:58:56 INFO - 2015-12-30 08:58:56,216 DEBUG : BROWSER_OUTPUT: Values: 803.5 809.5 878.1 921.5 952.2 13313.5 13427.9 13449.9 13456.5 13498.3 12649.7 12753.5 12773.0 12787.6 12808.9 738.5 749.3 891.3 903.4 904.9 899.0 902.8 908.2 910.8 910.9 939.0 946.1 951.7 952.7 954.4 936.5 939.8 940.3 941.4 944.4 698.5 701.0 701.6 702.7 705.5 12895.1 12969.9 12988.1 12989.3 13059.5 12763.8 12823.0 12871.1 12967.7 13466.5 10955.7 11122.2 11278.7 11326.3 11346.5 3817.9 3832.2 3841.7 3885.3 3897.5 51018.5 51059.0 51096.7 51418.2 51675.5 10433.9 11009.8 11335.4 11382.8 11475.5 18347.2 18355.4 18565.0 18588.7 18688.7 7378.9 7421.6 7423.7 7454.9 7512.0 4571.1 4611.6 4643.7 4666.8 4673.0 3113.9 3146.1 3157.2 3160.3 3162.7 560.5 571.3 574.9 581.0 585.3 704.7 707.1 714.3 718.7 741.7 8475.6 10184.9 10194.7 10380.5 10515.1 594.0 756.6 759.8 764.8 772.5 3652.3 3846.9 3971.1 4027.3 4029.5 55731.0 56322.7 56410.4 56475.7 57784.1 48736.5 48893.5 49112.0 49656.8 49804.0 46471.5 46874.0 47135.0 47301.1 47582.8 9091.6 9106.4 9273.8 9449.2 9580.5 34828.8 35013.5 35182.0 35332.6 36067.8 37770.2 39517.6 42968.6 43748.3 43798.6 11195.0 11320.0 11585.2 11592.1 11924.5 12964.1 13207.5 13271.0 13828.9 13911.3 12190.4 12423.4 12457.1 12472.3 12732.3 11917.0 12342.5 12371.8 12675.2 12950.8 12015.5 12162.1 12176.3 12470.3 12764.1 10672.4 10754.9 10799.3 10831.9 10993.5 10021.4 10307.0 10477.6 10480.7 10512.2 08:58:56 INFO - 2015-12-30 08:58:56,216 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:58:56 INFO - 2015-12-30 08:58:56,216 DEBUG : BROWSER_OUTPUT: 08:58:56 INFO - 2015-12-30 08:58:56,873 INFO : Browser exited with error code: 0 08:58:56 INFO - 2015-12-30 08:58:56,892 INFO : Completed test dromaeo_css (00:18:28) 08:58:56 INFO - 2015-12-30 08:58:56,892 INFO : Starting test kraken 08:58:56 INFO - 2015-12-30 08:58:56,892 DEBUG : operating with platform_type : linux_ 08:58:56 INFO - 2015-12-30 08:58:56,892 INFO : Initialising browser for kraken test... 08:58:56 INFO - 2015-12-30 08:58:56,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX8XwnX/profile http://localhost:47306/getInfo.html 08:59:00 INFO - 2015-12-30 08:59:00,986 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:59:00 INFO - 2015-12-30 08:59:00,987 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:59:00 INFO - 2015-12-30 08:59:00,987 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:59:00 INFO - 2015-12-30 08:59:00,987 DEBUG : BROWSER_OUTPUT: __metrics 08:59:01 INFO - 2015-12-30 08:59:01,945 INFO : Browser initialized. 08:59:01 INFO - 2015-12-30 08:59:01,946 INFO : Running cycle 1/1 for kraken test... 08:59:01 INFO - 2015-12-30 08:59:01,946 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpX8XwnX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:59:13 INFO - 2015-12-30 08:59:13,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 137048064 08:59:13 INFO - 2015-12-30 08:59:13,730 DEBUG : BROWSER_OUTPUT: 08:59:16 INFO - 2015-12-30 08:59:16,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47306/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:16 INFO - 2015-12-30 08:59:16,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 137736192 08:59:16 INFO - 2015-12-30 08:59:16,798 DEBUG : BROWSER_OUTPUT: 08:59:19 INFO - 2015-12-30 08:59:19,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47306/tests/kraken/driver.html?testName=audio-dft) 08:59:20 INFO - 2015-12-30 08:59:20,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 138207232 08:59:20 INFO - 2015-12-30 08:59:20,017 DEBUG : BROWSER_OUTPUT: 08:59:22 INFO - 2015-12-30 08:59:22,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47306/tests/kraken/driver.html?testName=audio-fft) 08:59:23 INFO - 2015-12-30 08:59:23,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 08:59:23 INFO - 2015-12-30 08:59:23,431 DEBUG : BROWSER_OUTPUT: 08:59:25 INFO - 2015-12-30 08:59:25,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47306/tests/kraken/driver.html?testName=audio-oscillator) 08:59:26 INFO - 2015-12-30 08:59:26,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 138268672 08:59:26 INFO - 2015-12-30 08:59:26,005 DEBUG : BROWSER_OUTPUT: 08:59:28 INFO - 2015-12-30 08:59:28,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:28 INFO - 2015-12-30 08:59:28,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 08:59:28 INFO - 2015-12-30 08:59:28,765 DEBUG : BROWSER_OUTPUT: 08:59:31 INFO - 2015-12-30 08:59:31,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47306/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:32 INFO - 2015-12-30 08:59:32,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 138518528 08:59:32 INFO - 2015-12-30 08:59:32,289 DEBUG : BROWSER_OUTPUT: 08:59:35 INFO - 2015-12-30 08:59:35,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47306/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:36 INFO - 2015-12-30 08:59:36,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138403840 08:59:36 INFO - 2015-12-30 08:59:36,186 DEBUG : BROWSER_OUTPUT: 08:59:38 INFO - 2015-12-30 08:59:38,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47306/tests/kraken/driver.html?testName=json-parse-financial) 08:59:39 INFO - 2015-12-30 08:59:39,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 138866688 08:59:39 INFO - 2015-12-30 08:59:39,548 DEBUG : BROWSER_OUTPUT: 08:59:41 INFO - 2015-12-30 08:59:41,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:41 INFO - 2015-12-30 08:59:41,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 137900032 08:59:41 INFO - 2015-12-30 08:59:41,724 DEBUG : BROWSER_OUTPUT: 08:59:43 INFO - 2015-12-30 08:59:43,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:44 INFO - 2015-12-30 08:59:44,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 138076160 08:59:44 INFO - 2015-12-30 08:59:44,093 DEBUG : BROWSER_OUTPUT: 08:59:46 INFO - 2015-12-30 08:59:46,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:46 INFO - 2015-12-30 08:59:46,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 139640832 08:59:46 INFO - 2015-12-30 08:59:46,752 DEBUG : BROWSER_OUTPUT: 08:59:49 INFO - 2015-12-30 08:59:49,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:49 INFO - 2015-12-30 08:59:49,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 08:59:49 INFO - 2015-12-30 08:59:49,722 DEBUG : BROWSER_OUTPUT: 08:59:52 INFO - 2015-12-30 08:59:52,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:52 INFO - 2015-12-30 08:59:52,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 139821056 08:59:52 INFO - 2015-12-30 08:59:52,860 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47306/tests/kraken/driver.html?testName=ai-astar) 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 138973184 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;106;112;111;112;123;112;114;111;111 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;128;153;156;125;156;151;130;162;123 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;164;162;163;163;164;164 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;71;73;149;73;71;71;73;154;71 08:59:54 INFO - 2015-12-30 08:59:54,784 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;91;141;91;94;93;137;92;93;132 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;110;110;110;109 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;148;147;146;146;148;145;146 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;96;97;95;96;97;96;96 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;63;63;61;62;62;60;61;63;59 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;63;63;63;65;64;64;64;64 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;89;85;84;84;84;82;92;84;84 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;119;115;120;117;114;121;118;119;120 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;162;151;151;150;139;151;163;140;138 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;67;69;68;67;68;70;71;67 08:59:54 INFO - 2015-12-30 08:59:54,785 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:59:54 INFO - 2015-12-30 08:59:54,786 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:59:54 INFO - 2015-12-30 08:59:54,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,718 08:59:54 INFO - 2015-12-30 08:59:54,786 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:59:54 INFO - 2015-12-30 08:59:54,786 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494794783__endTimestamp 08:59:54 INFO - 2015-12-30 08:59:54,786 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.32 (3.9%) stddev-sans-first:4.50 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: Values: 115.0 106.0 112.0 111.0 112.0 123.0 112.0 114.0 111.0 111.0 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:154.50 stddev:15.51 (10.0%) stddev-sans-first:15.73 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: Values: 157.0 128.0 153.0 156.0 125.0 156.0 151.0 130.0 162.0 123.0 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.51 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 164.0 162.0 163.0 163.0 164.0 164.0 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,794 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:72.00 stddev:33.51 (46.5%) stddev-sans-first:35.15 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 73.0 149.0 73.0 71.0 71.0 73.0 154.0 71.0 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:92.50 stddev:21.43 (23.2%) stddev-sans-first:22.30 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 94.0 91.0 141.0 91.0 94.0 93.0 137.0 92.0 93.0 132.0 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 148.0 147.0 146.0 146.0 148.0 145.0 146.0 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 96.0 97.0 95.0 96.0 97.0 96.0 96.0 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 08:59:54 INFO - 2015-12-30 08:59:54,795 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 63.0 61.0 62.0 62.0 60.0 61.0 63.0 59.0 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 63.0 63.0 65.0 64.0 64.0 64.0 64.0 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.25 (3.9%) stddev-sans-first:3.12 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: Values: 81.0 89.0 85.0 84.0 84.0 84.0 82.0 92.0 84.0 84.0 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:119.50 stddev:2.72 (2.3%) stddev-sans-first:2.37 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: Values: 123.0 119.0 115.0 120.0 117.0 114.0 121.0 118.0 119.0 120.0 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.00 stddev:8.69 (5.8%) stddev-sans-first:9.21 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: Values: 148.0 162.0 151.0 151.0 150.0 139.0 151.0 163.0 140.0 138.0 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: 08:59:54 INFO - 2015-12-30 08:59:54,796 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 08:59:54 INFO - 2015-12-30 08:59:54,797 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 69.0 68.0 67.0 68.0 70.0 71.0 67.0 08:59:54 INFO - 2015-12-30 08:59:54,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:59:54 INFO - 2015-12-30 08:59:54,797 DEBUG : BROWSER_OUTPUT: 08:59:55 INFO - 2015-12-30 08:59:55,657 INFO : Browser exited with error code: 0 08:59:55 INFO - 2015-12-30 08:59:55,708 INFO : Completed test kraken (00:00:58) 08:59:55 INFO - 2015-12-30 08:59:55,708 INFO : Starting test v8_7 08:59:55 INFO - 2015-12-30 08:59:55,708 DEBUG : operating with platform_type : linux_ 08:59:55 INFO - 2015-12-30 08:59:55,708 INFO : Initialising browser for v8_7 test... 08:59:55 INFO - 2015-12-30 08:59:55,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4z6858/profile http://localhost:47306/getInfo.html 08:59:59 INFO - 2015-12-30 08:59:59,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:59:59 INFO - 2015-12-30 08:59:59,938 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:59:59 INFO - 2015-12-30 08:59:59,938 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:59:59 INFO - 2015-12-30 08:59:59,938 DEBUG : BROWSER_OUTPUT: __metrics 09:00:00 INFO - 2015-12-30 09:00:00,869 INFO : Browser initialized. 09:00:00 INFO - 2015-12-30 09:00:00,870 INFO : Running cycle 1/1 for v8_7 test... 09:00:00 INFO - 2015-12-30 09:00:00,870 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4z6858/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:00:12 INFO - 2015-12-30 09:00:12,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 137170944 09:00:12 INFO - 2015-12-30 09:00:12,637 DEBUG : BROWSER_OUTPUT: 09:00:33 INFO - 2015-12-30 09:00:33,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47306/tests/v8_7/run.html (next: http://localhost:47306/tests/v8_7/run.html) 09:00:34 INFO - 2015-12-30 09:00:34,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 136974336 09:00:34 INFO - 2015-12-30 09:00:34,223 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,224 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:00:34 INFO - 2015-12-30 09:00:34,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |0;Richards;164.17665407978984 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.75004168751042 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 09:00:34 INFO - 2015-12-30 09:00:34,225 DEBUG : BROWSER_OUTPUT: |4;RayTrace;890.4719501335708 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: |6;Boyer;10648.936170212766 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: |7;RegExp;23952.380952380954 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: |8;Splay;528.5412262156448 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4878.048780487805 09:00:34 INFO - 2015-12-30 09:00:34,226 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494834223__endTimestamp 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,227 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.18 Median:164.18 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,228 DEBUG : BROWSER_OUTPUT: Values: 164.2 09:00:34 INFO - 2015-12-30 09:00:34,228 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,228 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,228 DEBUG : BROWSER_OUTPUT: Values: 166.8 09:00:34 INFO - 2015-12-30 09:00:34,228 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: Values: 280.0 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: Values: 5186.5 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,229 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:890.47 Median:890.47 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,230 DEBUG : BROWSER_OUTPUT: Values: 890.5 09:00:34 INFO - 2015-12-30 09:00:34,230 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,230 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,230 DEBUG : BROWSER_OUTPUT: Values: 542.6 09:00:34 INFO - 2015-12-30 09:00:34,230 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10648.94 Median:10648.94 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: Values: 10648.9 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23952.38 Median:23952.38 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: Values: 23952.4 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:528.54 Median:528.54 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,231 DEBUG : BROWSER_OUTPUT: Values: 528.5 09:00:34 INFO - 2015-12-30 09:00:34,232 DEBUG : BROWSER_OUTPUT: 09:00:34 INFO - 2015-12-30 09:00:34,233 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 09:00:34 INFO - 2015-12-30 09:00:34,233 DEBUG : BROWSER_OUTPUT: Values: 4878.0 09:00:34 INFO - 2015-12-30 09:00:34,233 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:00:34 INFO - 2015-12-30 09:00:34,233 DEBUG : BROWSER_OUTPUT: 09:00:35 INFO - 2015-12-30 09:00:35,053 INFO : Browser exited with error code: 0 09:00:35 INFO - 2015-12-30 09:00:35,068 INFO : Completed test v8_7 (00:00:39) 09:00:35 INFO - 2015-12-30 09:00:35,275 INFO : Completed test suite (00:20:06) 09:00:35 INFO - 2015-12-30 09:00:35,276 DEBUG : Working with test: dromaeo_css 09:00:35 INFO - 2015-12-30 09:00:35,276 DEBUG : Generating results file: dromaeo_css 09:00:35 INFO - 2015-12-30 09:00:35,277 DEBUG : Working with test: kraken 09:00:35 INFO - 2015-12-30 09:00:35,277 DEBUG : Generating results file: kraken 09:00:35 INFO - 2015-12-30 09:00:35,277 INFO : javascript benchmark 09:00:35 INFO - 2015-12-30 09:00:35,277 DEBUG : Working with test: v8_7 09:00:35 INFO - 2015-12-30 09:00:35,278 DEBUG : Generating results file: v8_7 09:00:35 INFO - 2015-12-30 09:00:35,278 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:35 INFO - 2015-12-30 09:00:35,335 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:00:35 INFO - 2015-12-30 09:00:35,335 DEBUG : process_Request line: dromaeo_css 7383.37 graph.html#tests=[[72,52,43]] 09:00:35 INFO - 2015-12-30 09:00:35,335 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:35 INFO - 2015-12-30 09:00:35,369 DEBUG : process_Request line: kraken 1511.80 graph.html#tests=[[232,52,43]] 09:00:35 INFO - 2015-12-30 09:00:35,369 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:00:35 INFO - 2015-12-30 09:00:35,405 DEBUG : process_Request line: v8_7 23401.61 graph.html#tests=[[230,52,43]] 09:00:35 INFO - 2015-12-30 09:00:35,406 INFO : javascript benchmark 09:00:35 INFO - 2015-12-30 09:00:35,410 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3284.5565848610436, 3294.8187849668275, 3297.670232976704, 3324.983375083125, 3326.4677651575753, 5266.631335806495, 5277.0, 5282.418933917266, 5284.471552844713, 5292.311999440077, 5250.4487028861895, 5296.232046353276, 5297.602679799021, 5299.33758280215, 5302.708351040691, 4826.083044221596, 4857.878553036167, 4888.486708895568, 4897.04507621014, 4922.360093187881, 4816.686915350509, 4877.292792545079, 4950.9257361139435, 4953.281774142747, 4987.027529631723, 4846.466888642264, 4900.607951363901, 4916.606671466274, 4920.68015578988, 5003.324551185579, 4983.875403114915, 4992.950070499285, 4994.725290109042, 5018.5232402921665, 5040.899182016357, 4707.364505791708, 4741.57325840676, 4810.4467986181335, 4936.3829521309835, 4944.431390390079, 5113.181890897476, 5136.43499215086, 5153.793848246066, 5162.535371816554, 5163.63854530183, 5736.827895163152, 5757.82726518201, 5767.971160144214, 5772.251896404684, 5790.507806836424, 5607.102863541813, 5644.435556444364, 5802.303723553158, 5810.157527158581, 5933.19901813254, 5467.0, 5486.149646804752, 5487.149491828773, 5495.175723641446, 5503.477169668875, 5924.052151655715, 5928.555358348141, 5928.733207005609, 5932.703364831741, 5939.0, 5493.752781124859, 5609.6353737007785, 5647.463490968352, 5716.085426331767, 5751.769929202868, 5778.422157784272, 5820.854478637983, 5853.678047707332, 5860.355360910296, 5874.060150375919, 5567.610267281251, 5803.274590676166, 5815.854603634943, 5818.44724751148, 5819.447152520504, 5636.210930469738, 5638.9436105638415, 5698.031334673115, 5700.828975130753, 5724.370319264877, 4451.844185453494, 4463.174312752151, 4478.820847166142, 4502.684812063189, 4513.977430112828, 3918.52977642679, 3993.3610622300293, 4034.152827906114, 4049.6152865477734, 4081.7346872453195, 5444.183372494078, 5444.7822087116865, 5460.453954604587, 5463.672179669233, 5495.945040549624, 5805.303363596396, 5836.095405212199, 5842.503387212135, 5844.152597873284, 5848.064309710426, 5447.53695935842, 5486.91769623456, 5553.583481238923, 5592.972035139798, 5622.0, 4921.434035085939, 4939.135651261086, 4939.185034469344, 4946.258061290835, 4949.282354058713, 5981.730822113015, 5984.1921340618455, 5999.580029397987, 5999.880002400015, 6027.60820546663, 5568.526675232651, 5648.774049037993, 5700.173474846207, 5809.0415081512765, 5860.120981852756, 5908.261467316585, 5917.112433135064, 5918.053111502139, 5923.911141332969, 5994.0, 5711.314642242957, 5716.42835716425, 5722.055860782924, 5723.885522289447, 5737.282839645044, 5556.777728890799, 5623.493885550157, 5697.829065128053, 5776.480116789509, 5800.158976948234, 5671.8865622688145, 5681.346645135863, 5705.486506214461, 5705.885882282414, 5706.029974904359, 5406.567474601944, 5650.519705825051, 5681.0626246668835, 5696.316442026983, 5703.144528320785, 5523.7238138093735, 5544.916826247529, 5551.8889622206525, 5577.6653400796085, 5595.132754423071, 5691.800786972436, 5719.628224165416, 5767.336756273083, 5770.740316685676, 5784.5083167929515, 5401.027814993182, 5492.0663487206475, 5587.860303492445, 5637.746301416528, 5671.0359238930305], "unit": "ms", "name": "dojo.html", "value": 5325.726049659987}, {"lowerIsBetter": false, "replicates": [565.9122835960426, 568.1789813719175, 569.2684899903625, 585.7159277750293, 593.2613895699855, 40360.0, 41131.794341028326, 41330.17339653205, 41430.17139657205, 41443.58556414435, 46395.53604463954, 46994.53005469944, 47007.29489057667, 47083.0, 47096.764516177456, 9209.125133112344, 9327.860082098774, 9348.766280842965, 9361.344705870591, 9408.388454750419, 9048.276137908952, 9057.773555661095, 9066.909330906705, 9127.406718563305, 9134.680286189985, 6838.589684618914, 6908.309169083077, 6910.481713871454, 6922.06552115463, 7037.190723066861, 9100.08999100088, 9210.67762628308, 9217.539123043854, 9220.354575179741, 9223.67717129904, 8922.241609463203, 9104.590293436744, 9120.0, 9123.498207598579, 9138.54307284633, 43570.56429435697, 44121.11757764859, 44169.55830441687, 44220.778896105636, 44245.336319955226, 3106.6116735408073, 3669.9633003669887, 3723.2181241938956, 3785.337565925952, 4011.859584914514, 30765.077047688606, 31033.22416939572, 31096.067117986495, 31423.0, 31746.206344841332, 3752.5496940367057, 3796.4495148203355, 3821.8662346817728, 3875.6318149775725, 3884.883453496371, 252526.0, 254767.0, 255123.0, 255426.0, 255957.0, 44152.11695766067, 44297.33553996692, 44584.55415445869, 44589.33116003263, 59834.0, 41953.580464194965, 42157.78921105375, 42186.0, 42197.0, 42218.78890605527, 15724.213789310488, 16314.67370652604, 16352.591185220464, 16420.83579164217, 16431.91784041096, 12404.441800119017, 12496.81254781179, 12527.812082818766, 12549.937250313873, 12609.180403273758, 14909.850901491063, 15141.394344226108, 15141.621459463602, 15162.848371516144, 15196.772048419283, 6004.519638428916, 6109.678322237522, 6142.754289828446, 6184.165137706442, 6198.411150940744, 977.1108291454742, 1038.4496217004998, 1057.814882395593, 1118.6028959719345, 1152.8241193982092, 29857.85071074631, 29963.550546741815, 30022.699773002427, 30493.542596861065, 30810.0, 1098.1050443888205, 1134.393099691661, 1148.1446322489633, 1157.548556063136, 1165.81929800881, 17213.655726885394, 17459.47621571355, 17702.645947080986, 17819.10904454772, 17944.013079280765, 446686.0, 585869.0, 586628.0, 878926.0, 905603.9439605651, 62399.376006240265, 62861.37138628647, 63457.0, 63604.36395635984, 63643.0, 1560.7346751052576, 1571.4814111343458, 1576.1252504859683, 1576.7950166478283, 1588.1424031023118, 31757.364852702354, 32138.19654508656, 32547.51178732368, 33178.5023224647, 36327.0, 54596.0, 55440.445595543526, 55744.16383754328, 55813.16280255881, 55979.72010139923, 338194.0, 338424.0, 338732.0, 340885.0, 341131.0, 46482.767586161855, 46873.76563117163, 46962.76518617522, 47450.52549474599, 47557.524424756695, 50983.745081274355, 51271.74364128305, 51655.74172129115, 51670.22494662508, 51794.0, 43259.134817304104, 43652.781736091114, 44196.779016104716, 44593.33110003417, 45187.32219016783, 41847.37228941507, 41875.371869421375, 42198.367024494044, 42673.0, 42981.14037719165, 41072.79463602663, 41266.38100428436, 41327.58672413237, 41462.79268603637, 41609.79195104126, 37103.0, 37147.0, 37267.44098838574, 37335.25329493449, 38189.2362152761, 28477.0, 28831.711682882902, 28867.711322886502, 29145.7085429143, 29327.560086599144], "unit": "ms", "name": "ext.html", "value": 19891.763592774776}, {"lowerIsBetter": false, "replicates": [366.7377824855228, 368.15692065170776, 369.7079307347196, 370.42029224264024, 372.1180801500444, 17631.64736705267, 18324.725129123057, 18719.438416847483, 19103.71344429831, 19738.0, 11536.01943834773, 11552.0, 11568.942155289213, 11619.535218591247, 11860.881391186085, 5078.289039534468, 5095.082885080693, 5228.581713462933, 5241.42344342122, 5252.8161514347, 5120.820771273006, 5121.769520371592, 5147.279380886679, 5150.815312478132, 5172.560332371734, 5191.351081114861, 5208.765605547759, 5237.240600112981, 6563.1796025496815, 6767.154105736783, 6726.260111387744, 6763.8309042274095, 6781.694823732919, 6819.659017049153, 7082.858342833166, 6867.313268673142, 6886.69009894556, 6894.034835123037, 6901.895696688506, 6914.032035515032, 24373.756262437328, 24459.755402446102, 24626.138085167113, 25122.748772512405, 26104.60843087355, 2370.0401337458356, 2387.5224955008894, 2398.304491697406, 2473.406382468195, 2574.0, 15563.0, 15966.521004369888, 15989.360425582963, 16381.0, 16402.425915093034, 1904.5905130396893, 1972.80271972803, 2139.5613899150635, 2210.2153735424013, 2263.7283525976986, 71194.64402678005, 71602.64198678973, 76195.0, 78440.0, 78626.60686696644, 16669.91665041667, 16766.74849877253, 16802.915985419993, 16817.159142043092, 16917.661646766996, 26192.73807261903, 26298.86850565773, 26383.34041648974, 26458.470830583665, 26571.335716606853, 9758.75603109928, 9826.06652368024, 9853.753656158653, 9873.308868379288, 9980.351277166961, 8545.359098067669, 8584.356173287028, 8586.398952073296, 8592.914070859337, 8596.484210947363, 8318.792030199293, 8322.126176751353, 8328.0, 8344.707935222237, 8358.45670031446, 1878.6900161473477, 3102.705243001911, 3190.883190883219, 3263.368315842079, 3304.140923359944, 914.7850255190025, 957.683964291796, 1000.9149222316184, 1001.4191768774093, 1013.0882206014498, 15048.774268385983, 16253.780966427565, 16613.83386166147, 17435.825641743675, 18101.09494525295, 938.7090002099371, 945.3571571331561, 1055.767731099157, 1089.782043591269, 1099.1591432554103, 9737.56180971858, 9814.214862810957, 9815.558299876522, 9836.06557377048, 9847.50762461874, 551583.0, 563122.0, 643791.0, 655581.0, 681796.0, 84849.57575212084, 85949.14050859536, 86783.0, 86834.56582717046, 87382.0, 1249.3316075899531, 1260.7730608490376, 1272.662744372742, 1277.0166971431945, 1289.6582405662318, 15081.849181508484, 15134.697306054037, 15252.618684532532, 15627.0, 15723.528294151194, 33156.66843331536, 33171.50242746409, 33798.15504612404, 34496.13759655928, 34618.0, 49615.0, 50230.246546302566, 51496.0, 54052.48803684246, 54614.0, 9920.107190352903, 10022.799544008933, 10051.899481005097, 10082.69751907444, 10146.340487868265, 12103.0, 12213.938930305292, 12218.633440996784, 15189.240537973279, 18460.81539184591, 13810.65473363174, 15045.699086018438, 15332.693346132792, 15529.301181447088, 15605.0, 15096.39614415411, 15134.016288941184, 15281.0, 15859.920700396424, 15920.124393158487, 16149.273282702072, 16171.191440428167, 16207.594810129369, 16319.836801632307, 16449.25978330954, 10041.196704263788, 10196.4391958443, 10247.538860751136, 10326.380417174994, 10349.63776267827, 15314.846851531342, 15364.692706145592, 15656.686866262839, 15736.370545178064, 16127.274272657523], "unit": "ms", "name": "jquery.html", "value": 10214.794695593275}, {"lowerIsBetter": false, "replicates": [1530.632648164441, 1541.8843586730998, 1742.1115231232068, 1801.2617823800033, 1834.5597056706395, 6338.683065846701, 6591.5715478493985, 7160.964195179024, 7378.299061589147, 7393.482456228066, 7330.816729581763, 7447.106347238339, 7493.887591686129, 7501.137369202544, 7521.398288136949, 2260.5930932432157, 2297.689811875392, 2302.044651469638, 2305.400595845084, 2306.4579823741406, 2274.749777524471, 2303.79265866072, 2318.5131122464304, 2319.536092781442, 2320.431494283903, 2259.6610508423787, 2280.407094155515, 2314.4213946513373, 2329.6389059695775, 2330.463993281546, 2258.2209137847417, 2269.2965180793926, 2291.106468477295, 2295.024614538823, 2300.6894069300683, 2323.581755284048, 2337.8012868905994, 2340.8010319122895, 2344.2732752846673, 2349.765023497637, 7540.396768258581, 7612.80967975805, 7618.200088990631, 7622.428317876182, 7660.348870346027, 4677.6491763117565, 4698.812047518095, 4722.976385118087, 4744.051189762027, 4746.21687421575, 3039.9392012159633, 3040.452718510667, 3091.6444608870042, 3094.0, 3118.4854499007865, 975.2831668723483, 994.6916455898695, 1005.1857995024054, 1025.6871654145482, 1031.2265800649513, 10138.442385668784, 10156.644517441853, 10162.59349626014, 10166.13587845034, 10174.694759157162, 4228.1966426378885, 4316.43886294786, 4317.438732964694, 4319.546447623017, 4346.913061738811, 8817.691380801769, 8820.470771753715, 8827.249683776823, 8830.823383532423, 8831.514266715392, 4807.78364973577, 4809.711417314972, 4815.566599006106, 4824.300476430968, 4826.61387089032, 4222.619964203175, 4247.5540068293, 4365.476142862877, 4452.532484089189, 4466.7766611669285, 3403.829808509565, 3414.0440676610588, 3442.862285508602, 3448.103493091814, 3453.0, 1020.4846552490944, 1021.0657248617432, 1030.5156576409076, 1030.922680798943, 1054.2356791326226, 1197.9820302695466, 1217.0385395537426, 1217.4764851113928, 1229.6188181663713, 1232.4946771823509, 7241.52930059555, 7255.637218139177, 7265.2371500992695, 7282.927170728225, 7461.253874612496, 1136.3068528197794, 1149.40231079838, 1161.5528021711532, 1193.4127610278483, 1196.2822306616135, 5741.25363702716, 5796.971015144982, 5811.535077193815, 5822.883542329215, 5831.504322132666, 8554.01628812682, 8949.284057275403, 9044.819103618023, 9116.4074335168, 9235.492047937294, 8888.155625215593, 8901.688440904538, 8921.063288354759, 9050.818983620291, 9055.773605659911, 7093.184283807325, 7141.714331426685, 7261.636918154071, 7269.164046134762, 7345.77962661121, 6695.12963314766, 6702.865942681022, 6728.966355168192, 6733.966330168318, 6753.189617245962, 7881.842363152819, 8106.351491880518, 8190.180981902001, 8335.833283334421, 8363.916360836558, 8161.347092232726, 8269.751907442786, 8296.626651800803, 8404.159584041547, 8488.915110848813, 5918.526517878646, 6050.364711705383, 6558.1802274715665, 6575.375339342755, 6706.66466676674, 7051.294870512907, 7053.400460960671, 7073.115860517435, 7084.397826184832, 7105.964470177616, 6897.93102068993, 7056.788296351117, 7058.435325174077, 7111.60886151246, 7157.1769246537315, 6588.505862060269, 6702.162229721285, 6712.160979877515, 6767.729290828312, 6862.382385585322, 6819.0, 6947.5831450113155, 6956.5478243913985, 6958.686859091252, 7001.649917504206, 6298.338674439301, 6334.619922804646, 6350.968245158745, 6354.0, 6357.268914074941, 6463.385978332051, 6466.644334561644, 6496.0580715795, 6504.479641628753, 6506.967465162644], "unit": "ms", "name": "mootools.html", "value": 4424.639486668777}, {"lowerIsBetter": false, "replicates": [326.2512533735078, 330.9536664866918, 339.2637975592964, 352.9135361836351, 359.3764818040699, 6338.936610633892, 6342.556021078521, 6355.332690067546, 6432.871342573146, 6521.673916304189, 6350.237971443434, 6353.332900045487, 6362.681865906709, 6390.073439351291, 6391.616503009823, 4829.492903245161, 4844.539768721966, 4844.87887802806, 4847.127517046939, 4848.97575512122, 4863.076015557051, 4863.294822250771, 4863.513648635144, 4866.416030076396, 4878.243872199797, 4677.579017888389, 4698.036902434993, 4775.856724298276, 4795.688280261772, 4805.351277577534, 4761.047790441926, 4767.547083027107, 4786.234202527578, 4796.52034796521, 4799.712017278957, 4179.373094035888, 4179.937300940488, 4186.958130418688, 4188.183304255671, 4195.517515485728, 5975.462208401264, 5988.520918326523, 5995.2206213192, 6007.819765407001, 6013.368596297413, 5525.861853453655, 5597.972010139923, 5609.242752228479, 5616.0, 5617.466340697627, 6665.266820649725, 6705.430038446689, 6706.429953453962, 6711.463082953352, 6718.966405167992, 4632.119897219518, 4637.188492013918, 4643.512431194744, 4651.8835479485015, 4655.604273636745, 6748.987651852212, 6854.485913556503, 6911.3779759821855, 6963.373296403297, 6968.756093536702, 4733.834315798999, 4737.431508219036, 4742.407199100113, 4746.38297021385, 4748.525147485293, 4793.400824896888, 4808.567228949341, 4815.855524334275, 4815.975920120377, 4822.95177048232, 5572.498475137176, 5582.832515024475, 5586.217929489874, 5591.552675786009, 5601.383847776741, 6586.934130658728, 6759.121314229119, 6804.727810887509, 6805.727770889109, 6838.418734407631, 1673.6067024249292, 1688.0546893739545, 1690.7294832826935, 1691.323470611765, 1696.2706036404466, 1126.1553834624033, 1126.5437497813398, 1133.4389477208833, 1136.3522792008475, 1153.066016526616, 6518.054882042172, 6577.046328282468, 6585.209774827052, 6585.440237579859, 6601.603903765789, 6895.448364130958, 6946.548474349152, 6960.895586566206, 6967.477439191979, 6977.33715297046, 6503.512236582275, 6508.8047358579315, 6570.934290657032, 6582.144321238304, 6592.604443733296, 3783.9243215135543, 3799.3920972644246, 3816.8282427290283, 3835.6356146166067, 3839.8080095995088, 7282.235365286675, 7289.817754556178, 7295.343419092307, 7297.854042919112, 7306.415486761046, 7079.752208672672, 7176.96411517939, 7241.42068634508, 7242.855142897112, 7254.818629534198, 7257.237990011078, 7257.782266532013, 7261.491695581259, 7268.055152830204, 7300.598467084255, 6959.930400695928, 6986.6855991481525, 7005.54463959841, 7015.824604384931, 7019.3682568569075, 6733.326667333227, 6908.516403851682, 6914.101166848278, 6953.582785032914, 6996.0, 7246.384057355184, 7269.200387957215, 7271.2365201653065, 7283.089613798275, 7283.526570772883, 4819.542143496362, 4888.755562221803, 4889.535494128052, 4904.779284932258, 4915.7542122893, 6801.693923773343, 6935.514513984174, 6948.687309071205, 6948.826279343057, 6953.748325301494, 6793.252742198255, 6798.52410331272, 6818.215905170969, 6818.693158807965, 6823.965880170567, 6670.266270710315, 6739.966300168468, 6782.118324617965, 6782.525223234524, 6789.2192397872905, 6693.230278517838, 6696.263411024686, 6698.631575263407, 6701.497387695845, 6706.094677218708, 6902.896456553055, 6913.9974703668695, 6918.5502942308585, 6923.376896079377, 6923.411510021503, 6640.601563906181, 6707.5975441473665, 6737.124173857367, 6742.359475849787, 6750.6624668767345], "unit": "ms", "name": "prototype.html", "value": 5089.173685131743}, {"lowerIsBetter": false, "replicates": [803.5459965119707, 809.4900212865894, 878.113105763179, 921.5438358012784, 952.1763674421625, 13313.53402630908, 13427.93286033571, 13449.932750336247, 13456.461741530327, 13498.257595832225, 12649.683757906058, 12753.489860405572, 12773.0, 12787.552435664753, 12808.93595532021, 738.5347231244309, 749.2769477454256, 891.3003292415423, 903.3541018172006, 904.9049849765779, 898.9775255618629, 902.7923577577161, 908.2007833106857, 910.8497097978826, 910.899801021887, 939.037486576258, 946.1201082992814, 951.7002144324516, 952.7141857442774, 954.3653470442148, 936.5036530638738, 939.8120375924774, 940.275987489636, 941.444547716847, 944.4144630329206, 698.4726531468759, 700.9509334346598, 701.6281370873445, 702.6556987076347, 705.4990956420947, 12895.09734318598, 12969.935150324281, 12988.090833641649, 12989.285589292585, 13059.542915997894, 12763.808542871864, 12823.0, 12871.09902306839, 12967.675808104872, 13466.487802454434, 10955.671329860117, 11122.165837562134, 11278.661640150809, 11326.26379285352, 11346.546138154465, 3817.9045523861846, 3832.156925476391, 3841.7310788244836, 3885.2812229737588, 3897.4933258676474, 51018.48981510212, 51059.0, 51096.744516277555, 51418.228726568756, 51675.483245167445, 10433.895661043443, 11009.83485247722, 11335.376554289593, 11382.772344553228, 11475.483603237873, 18347.17437715306, 18355.35756248525, 18565.0, 18588.721169182474, 18688.719669204973, 7378.852422951511, 7421.591812450259, 7423.665935032828, 7454.85090298191, 7511.9624401877645, 4571.131485017836, 4611.584957353787, 4643.74459404736, 4666.766661666903, 4672.976635116871, 3113.8910138145056, 3146.11908665574, 3157.163351711798, 3160.336329370812, 3162.667919868427, 560.529155509366, 571.2687759667632, 574.9425057494217, 580.9796657116981, 585.2625691628579, 704.6688056613383, 707.1372925031453, 714.3035540348119, 718.7448455798117, 741.7366834773685, 8475.57622118904, 10184.898151018544, 10194.674692290104, 10380.480975951172, 10515.05364517197, 593.9584229103921, 756.5990025286607, 759.8290384663406, 764.7820371194183, 772.5441989226271, 3652.251288485854, 3846.9230615387537, 3971.0866500705, 4027.275090483741, 4029.476168098187, 55731.0, 56322.718386408626, 56410.43589564134, 56475.71762141163, 57784.133238001465, 48736.51263487391, 48893.51106488961, 49112.0, 49656.75171624191, 49804.01175929456, 46471.5352846474, 46874.0, 47135.0, 47301.05397892023, 47582.762086189345, 9091.636334546543, 9106.408083474553, 9273.814523709623, 9449.244060475008, 9580.520973951136, 34828.78099266615, 35013.47479787856, 35182.0, 35332.64667353396, 36067.81966090153, 37770.244595108496, 39517.60482395254, 42968.570314296456, 43748.34377484277, 43798.56201437945, 11195.048420884315, 11320.0, 11585.189036767346, 11592.1305902056, 11924.463399147233, 12964.09251352434, 13207.471701131846, 13271.0, 13828.930855346061, 13911.304434778423, 12190.390480475764, 12423.37883105823, 12457.12800103984, 12472.251664900135, 12732.299723515296, 11917.0, 12342.506299747909, 12371.814422783485, 12675.17611355259, 12950.805737914126, 12015.519379225083, 12162.087843411602, 12176.330301833485, 12470.314132722788, 12764.106512544033, 10672.413017284123, 10754.89245107539, 10799.298045627009, 10831.891681083089, 10993.505292261707, 10021.448820314661, 10307.020833020852, 10477.580896764044, 10480.68557943263, 10512.159027277647], "unit": "ms", "name": "yui.html", "value": 6647.8093030674045}], "name": "dromaeo_css", "value": 7383.368458369424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 112.0, 111.0, 112.0, 123.0, 112.0, 114.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 153.0, 156.0, 125.0, 156.0, 151.0, 130.0, 162.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 164.0, 162.0, 163.0, 163.0, 164.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 73.0, 149.0, 73.0, 71.0, 71.0, 73.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [94.0, 91.0, 141.0, 91.0, 94.0, 93.0, 137.0, 92.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 63.0, 61.0, 62.0, 62.0, 60.0, 61.0, 63.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 85.0, 84.0, 84.0, 84.0, 82.0, 92.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 115.0, 120.0, 117.0, 114.0, 121.0, 118.0, 119.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [148.0, 162.0, 151.0, 151.0, 150.0, 139.0, 151.0, 163.0, 140.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 69.0, 68.0, 67.0, 68.0, 70.0, 71.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1511.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.17665407978984], "unit": "score", "name": "Richards", "value": 215.02448200000006}, {"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "DeltaBlue", "value": 396.50964599999986}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [890.4719501335708], "unit": "score", "name": "RayTrace", "value": 831.0076470000001}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [10648.936170212766], "unit": "score", "name": "Boyer", "value": 62.5849370629371}, {"lowerIsBetter": false, "replicates": [23952.380952380954], "unit": "score", "name": "RegExp", "value": 38.0331709741551}, {"lowerIsBetter": false, "replicates": [528.5412262156448], "unit": "score", "name": "Splay", "value": 154.18097200000005}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 23401.614478127492}]} 09:00:35 INFO - RETURN: dromaeo_css: 7383.37 09:00:35 INFO - RETURN: kraken: 1511.80 09:00:35 INFO - RETURN: v8_7: 23401.61 09:00:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23401.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1511.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7383.37"}}} 09:00:35 INFO - Return code: 0 09:00:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:00:35 INFO - # TBPL SUCCESS # 09:00:35 INFO - Running post-action listener: _resource_record_post_action 09:00:35 INFO - Running post-run listener: _resource_record_post_run 09:00:36 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502996992; Read time: 8; Write time: 428804 09:00:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237314048; Read time: 0; Write time: 290540 09:00:36 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 265682944; Read time: 8; Write time: 138264 09:00:36 INFO - Running post-run listener: _upload_blobber_files 09:00:36 INFO - Blob upload gear active. 09:00:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:00:36 INFO - Copying logs to upload dir... 09:00:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.483656 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-30 09:00:36.315180) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 09:00:36.319337) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009544 build_url: 'https://queue.taskcluster.net/v1/task/_wwgobedRe2X1qgHrzqA-g/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 09:00:36.378740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 09:00:36.379474) ========= 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=f5f5a079460e1a9be8676904000001c1-1451488667.616709-204729775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 09:00:36.432919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 09:00:36.433494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 09:00:36.434043) ========= ========= Total master_lag: 0.26 =========