builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1449251835.96 results: success (0) buildid: 20151204051719 builduid: 4e5875c2372d406e8e926ce3f3599ba4 revision: f339f85d742e28e801b4d7c25004538efd73e2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.955789) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.956334) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.956619) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006186 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.979326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.979628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.992724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:15.993107) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.042056) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.042433) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.042804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.043095) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 09:57:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.1M=0s 2015-12-04 09:57:16 (77.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.232786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.233113) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018291 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:16.283220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 09:57:16.283600) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f339f85d742e28e801b4d7c25004538efd73e2b1 --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 f339f85d742e28e801b4d7c25004538efd73e2b1 --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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 09:57:16,930 truncating revision to first 12 chars 2015-12-04 09:57:16,930 Setting DEBUG logging. 2015-12-04 09:57:16,930 attempt 1/10 2015-12-04 09:57:16,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f339f85d742e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 09:57:17,746 unpacking tar archive at: mozilla-aurora-f339f85d742e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.113395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-04 09:57:17.410009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:17.410326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:17.420648) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:17.420959) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 09:57:17.421388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-12-04 09:57:17.421669) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --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', '--system-bits', '64', '--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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:18 INFO - MultiFileLogger online at 20151204 09:57:18 in /builds/slave/test-pgo 09:57:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:57:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:57:18 INFO - {'append_to_log': False, 09:57:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:57:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:57:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:57:18 INFO - 'branch': 'Mozilla-Aurora', 09:57:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:18 INFO - 'config_files': ('talos/linux_config.py',), 09:57:18 INFO - 'default_actions': ('clobber', 09:57:18 INFO - 'read-buildbot-config', 09:57:18 INFO - 'download-and-extract', 09:57:18 INFO - 'populate-webroot', 09:57:18 INFO - 'create-virtualenv', 09:57:18 INFO - 'install', 09:57:18 INFO - 'run-tests'), 09:57:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:18 INFO - 'download_minidump_stackwalk': True, 09:57:18 INFO - 'download_symbols': 'ondemand', 09:57:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:18 INFO - 'installer_path': 'installer.exe', 09:57:18 INFO - 'log_level': 'info', 09:57:18 INFO - 'log_name': 'talos', 09:57:18 INFO - 'log_to_console': True, 09:57:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:18 INFO - 'opt_config_files': (), 09:57:18 INFO - 'pip_index': False, 09:57:18 INFO - 'sps_profile': False, 09:57:18 INFO - 'sps_profile_interval': 0, 09:57:18 INFO - 'suite': 'dromaeojs-e10s', 09:57:18 INFO - 'system_bits': '64', 09:57:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:18 INFO - 'title': 'talos-linux64-ix-014', 09:57:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:18 INFO - 'use_talos_json': True, 09:57:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:57:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:18 INFO - 'work_dir': 'build'} 09:57:18 INFO - ##### 09:57:18 INFO - ##### Running clobber step. 09:57:18 INFO - ##### 09:57:18 INFO - Running pre-action listener: _resource_record_pre_action 09:57:18 INFO - Running main action method: clobber 09:57:18 INFO - rmtree: /builds/slave/test-pgo/build 09:57:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:57:18 INFO - Running post-action listener: _resource_record_post_action 09:57:18 INFO - ##### 09:57:18 INFO - ##### Running read-buildbot-config step. 09:57:18 INFO - ##### 09:57:18 INFO - Running pre-action listener: _resource_record_pre_action 09:57:18 INFO - Running main action method: read_buildbot_config 09:57:18 INFO - Using buildbot properties: 09:57:18 INFO - { 09:57:18 INFO - "properties": { 09:57:18 INFO - "buildnumber": 12, 09:57:18 INFO - "product": "firefox", 09:57:18 INFO - "script_repo_revision": "production", 09:57:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:57:18 INFO - "repository": "", 09:57:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:57:18 INFO - "buildid": "20151204051719", 09:57:18 INFO - "slavename": "talos-linux64-ix-014", 09:57:18 INFO - "pgo_build": "True", 09:57:18 INFO - "basedir": "/builds/slave/test-pgo", 09:57:18 INFO - "project": "", 09:57:18 INFO - "platform": "ubuntu64_hw", 09:57:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:18 INFO - "slavebuilddir": "test", 09:57:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:57:18 INFO - "branch": "mozilla-aurora", 09:57:18 INFO - "repo_path": "releases/mozilla-aurora", 09:57:18 INFO - "stage_platform": "linux64-pgo", 09:57:18 INFO - "builduid": "4e5875c2372d406e8e926ce3f3599ba4", 09:57:18 INFO - "revision": "f339f85d742e28e801b4d7c25004538efd73e2b1" 09:57:18 INFO - }, 09:57:18 INFO - "sourcestamp": { 09:57:18 INFO - "repository": "", 09:57:18 INFO - "hasPatch": false, 09:57:18 INFO - "project": "", 09:57:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:57:18 INFO - "changes": [ 09:57:18 INFO - { 09:57:18 INFO - "category": null, 09:57:18 INFO - "files": [ 09:57:18 INFO - { 09:57:18 INFO - "url": null, 09:57:18 INFO - "name": "https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2" 09:57:18 INFO - } 09:57:18 INFO - ], 09:57:18 INFO - "repository": "", 09:57:18 INFO - "rev": "f339f85d742e28e801b4d7c25004538efd73e2b1", 09:57:18 INFO - "who": "jmaher@mozilla.com", 09:57:18 INFO - "when": 1449251656, 09:57:18 INFO - "number": 6745219, 09:57:18 INFO - "comments": "Bug 1220132 - fix xperf-e10s command line parameters. r=wlach, a=test-only", 09:57:18 INFO - "project": "", 09:57:18 INFO - "at": "Fri 04 Dec 2015 09:54:16", 09:57:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:57:18 INFO - "revlink": "", 09:57:18 INFO - "properties": [ 09:57:18 INFO - [ 09:57:18 INFO - "buildid", 09:57:18 INFO - "20151204051719", 09:57:18 INFO - "Change" 09:57:18 INFO - ], 09:57:18 INFO - [ 09:57:18 INFO - "builduid", 09:57:18 INFO - "4e5875c2372d406e8e926ce3f3599ba4", 09:57:18 INFO - "Change" 09:57:18 INFO - ], 09:57:18 INFO - [ 09:57:18 INFO - "pgo_build", 09:57:18 INFO - "True", 09:57:18 INFO - "Change" 09:57:18 INFO - ] 09:57:18 INFO - ], 09:57:18 INFO - "revision": "f339f85d742e28e801b4d7c25004538efd73e2b1" 09:57:18 INFO - } 09:57:18 INFO - ], 09:57:18 INFO - "revision": "f339f85d742e28e801b4d7c25004538efd73e2b1" 09:57:18 INFO - } 09:57:18 INFO - } 09:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2. 09:57:18 INFO - Running post-action listener: _resource_record_post_action 09:57:18 INFO - ##### 09:57:18 INFO - ##### Running download-and-extract step. 09:57:18 INFO - ##### 09:57:18 INFO - Running pre-action listener: _resource_record_pre_action 09:57:18 INFO - Running main action method: download_and_extract 09:57:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:18 INFO - https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/test_packages.json 09:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/test_packages.json 09:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:57:19 INFO - Downloaded 1302 bytes. 09:57:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:57:19 INFO - Using the following test package requirements: 09:57:19 INFO - {u'common': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:19 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:19 INFO - u'jittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'jsshell-linux-x86_64.zip'], 09:57:19 INFO - u'mochitest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:19 INFO - u'mozbase': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:19 INFO - u'reftest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:57:19 INFO - u'talos': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:57:19 INFO - u'web-platform': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:19 INFO - u'webapprt': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:19 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:19 INFO - u'firefox-44.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:19 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:19 INFO - https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:20 INFO - Downloaded 22571322 bytes. 09:57:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:57:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:57:21 INFO - Return code: 0 09:57:21 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:21 INFO - https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:22 INFO - Downloaded 22571322 bytes. 09:57:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:57:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:57:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:57:23 INFO - Return code: 0 09:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:23 INFO - https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:57:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:57:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:57:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:57:24 INFO - Downloaded 11131970 bytes. 09:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:57:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:57:24 INFO - Return code: 0 09:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:24 INFO - https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:57:26 INFO - Downloaded 56732023 bytes. 09:57:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:57:26 INFO - mkdir: /builds/slave/test-pgo/properties 09:57:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:57:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:57:26 INFO - Contents: 09:57:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:57:26 INFO - Running post-action listener: _resource_record_post_action 09:57:26 INFO - Running post-action listener: set_extra_try_arguments 09:57:26 INFO - ##### 09:57:26 INFO - ##### Running populate-webroot step. 09:57:26 INFO - ##### 09:57:26 INFO - Running pre-action listener: _resource_record_pre_action 09:57:26 INFO - Running main action method: populate_webroot 09:57:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:57:26 INFO - '../fennec_ids.txt'], 09:57:26 INFO - 'tests': ['tcheck2']}, 09:57:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:26 INFO - '--tppagecycles', 09:57:26 INFO - '7'], 09:57:26 INFO - 'tests': ['tsvgm']}}, 09:57:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['damp', 'tps']}, 09:57:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['damp', 'tps']}, 09:57:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:26 INFO - 'other': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'other_l64': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:26 INFO - 'ts_paint', 09:57:26 INFO - 'tpaint', 09:57:26 INFO - 'sessionrestore', 09:57:26 INFO - 'sessionrestore_no_auto_restore']}, 09:57:26 INFO - 'svgr': {'tests': ['tsvgx', 09:57:26 INFO - 'tsvgr_opacity', 09:57:26 INFO - 'tart', 09:57:26 INFO - 'tscrollx', 09:57:26 INFO - 'cart']}, 09:57:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['tsvgx', 09:57:26 INFO - 'tsvgr_opacity', 09:57:26 INFO - 'tart', 09:57:26 INFO - 'tscrollx', 09:57:26 INFO - 'cart']}, 09:57:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'tests': ['tp5o']}, 09:57:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--e10s'], 09:57:26 INFO - 'tests': ['tp5o']}, 09:57:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--xperf_path', 09:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:26 INFO - 'tests': ['tp5n']}, 09:57:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:26 INFO - 'talos_options': ['--e10s', 09:57:26 INFO - '--xperf_path', 09:57:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:26 INFO - 'tests': ['tp5n']}}, 09:57:26 INFO - 'talos.zip': {'path': '', 09:57:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:26 INFO - Running post-action listener: _resource_record_post_action 09:57:26 INFO - ##### 09:57:26 INFO - ##### Running create-virtualenv step. 09:57:26 INFO - ##### 09:57:26 INFO - Running pre-action listener: _resource_record_pre_action 09:57:26 INFO - Running main action method: create_virtualenv 09:57:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:57:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:57:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:57:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:26 INFO - Using real prefix '/usr' 09:57:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:57:27 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:29 INFO - Installing pip.................done. 09:57:29 INFO - Return code: 0 09:57:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:29 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 09:57:29 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 09:57:29 INFO - Using env: {'DISPLAY': ':0', 09:57:29 INFO - 'HOME': '/home/cltbld', 09:57:29 INFO - 'LANG': 'en_US.UTF-8', 09:57:29 INFO - 'LANGUAGE': 'en_US:en', 09:57:29 INFO - 'LOGNAME': 'cltbld', 09:57:29 INFO - 'MAIL': '/var/mail/cltbld', 09:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:29 INFO - 'MOZ_NO_REMOTE': '1', 09:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:29 INFO - 'NO_EM_RESTART': '1', 09:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:29 INFO - 'SHELL': '/bin/bash', 09:57:29 INFO - 'SHLVL': '1', 09:57:29 INFO - 'TERM': 'linux', 09:57:29 INFO - 'TMOUT': '86400', 09:57:29 INFO - 'USER': 'cltbld', 09:57:29 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:29 INFO - '_': '/tools/buildbot/bin/python'} 09:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:29 INFO - Cleaning up... 09:57:29 INFO - Return code: 0 09:57:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:29 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 09:57:29 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 09:57:29 INFO - Using env: {'DISPLAY': ':0', 09:57:29 INFO - 'HOME': '/home/cltbld', 09:57:29 INFO - 'LANG': 'en_US.UTF-8', 09:57:29 INFO - 'LANGUAGE': 'en_US:en', 09:57:29 INFO - 'LOGNAME': 'cltbld', 09:57:29 INFO - 'MAIL': '/var/mail/cltbld', 09:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:29 INFO - 'MOZ_NO_REMOTE': '1', 09:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:29 INFO - 'NO_EM_RESTART': '1', 09:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:29 INFO - 'SHELL': '/bin/bash', 09:57:29 INFO - 'SHLVL': '1', 09:57:29 INFO - 'TERM': 'linux', 09:57:29 INFO - 'TMOUT': '86400', 09:57:29 INFO - 'USER': 'cltbld', 09:57:29 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:29 INFO - '_': '/tools/buildbot/bin/python'} 09:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:29 INFO - Downloading/unpacking psutil>=0.7.1 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:31 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:57:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:57:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:31 INFO - Installing collected packages: psutil 09:57:31 INFO - Running setup.py install for psutil 09:57:31 INFO - building 'psutil._psutil_linux' extension 09:57:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:57:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:57:31 INFO - building 'psutil._psutil_posix' extension 09:57:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:57:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:57:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:32 INFO - Successfully installed psutil 09:57:32 INFO - Cleaning up... 09:57:32 INFO - Return code: 0 09:57:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:32 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:32 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 09:57:32 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 09:57:32 INFO - Using env: {'DISPLAY': ':0', 09:57:32 INFO - 'HOME': '/home/cltbld', 09:57:32 INFO - 'LANG': 'en_US.UTF-8', 09:57:32 INFO - 'LANGUAGE': 'en_US:en', 09:57:32 INFO - 'LOGNAME': 'cltbld', 09:57:32 INFO - 'MAIL': '/var/mail/cltbld', 09:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:32 INFO - 'MOZ_NO_REMOTE': '1', 09:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:32 INFO - 'NO_EM_RESTART': '1', 09:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:32 INFO - 'SHELL': '/bin/bash', 09:57:32 INFO - 'SHLVL': '1', 09:57:32 INFO - 'TERM': 'linux', 09:57:32 INFO - 'TMOUT': '86400', 09:57:32 INFO - 'USER': 'cltbld', 09:57:32 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:32 INFO - '_': '/tools/buildbot/bin/python'} 09:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:57:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:33 INFO - Installing collected packages: mozsystemmonitor 09:57:33 INFO - Running setup.py install for mozsystemmonitor 09:57:34 INFO - Successfully installed mozsystemmonitor 09:57:34 INFO - Cleaning up... 09:57:34 INFO - Return code: 0 09:57:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:34 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 09:57:34 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 09:57:34 INFO - Using env: {'DISPLAY': ':0', 09:57:34 INFO - 'HOME': '/home/cltbld', 09:57:34 INFO - 'LANG': 'en_US.UTF-8', 09:57:34 INFO - 'LANGUAGE': 'en_US:en', 09:57:34 INFO - 'LOGNAME': 'cltbld', 09:57:34 INFO - 'MAIL': '/var/mail/cltbld', 09:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:34 INFO - 'MOZ_NO_REMOTE': '1', 09:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:34 INFO - 'NO_EM_RESTART': '1', 09:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:34 INFO - 'SHELL': '/bin/bash', 09:57:34 INFO - 'SHLVL': '1', 09:57:34 INFO - 'TERM': 'linux', 09:57:34 INFO - 'TMOUT': '86400', 09:57:34 INFO - 'USER': 'cltbld', 09:57:34 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:34 INFO - '_': '/tools/buildbot/bin/python'} 09:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:57:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:57:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:57:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - Downloading docopt-0.6.1.tar.gz 09:57:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:57:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:36 INFO - Running setup.py install for blobuploader 09:57:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:57:36 INFO - Running setup.py install for requests 09:57:37 INFO - Running setup.py install for docopt 09:57:37 INFO - Successfully installed blobuploader requests docopt 09:57:37 INFO - Cleaning up... 09:57:37 INFO - Return code: 0 09:57:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:37 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:37 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 09:57:37 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 09:57:37 INFO - Using env: {'DISPLAY': ':0', 09:57:37 INFO - 'HOME': '/home/cltbld', 09:57:37 INFO - 'LANG': 'en_US.UTF-8', 09:57:37 INFO - 'LANGUAGE': 'en_US:en', 09:57:37 INFO - 'LOGNAME': 'cltbld', 09:57:37 INFO - 'MAIL': '/var/mail/cltbld', 09:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:37 INFO - 'MOZ_NO_REMOTE': '1', 09:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:37 INFO - 'NO_EM_RESTART': '1', 09:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:37 INFO - 'SHELL': '/bin/bash', 09:57:37 INFO - 'SHLVL': '1', 09:57:37 INFO - 'TERM': 'linux', 09:57:37 INFO - 'TMOUT': '86400', 09:57:37 INFO - 'USER': 'cltbld', 09:57:37 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:37 INFO - '_': '/tools/buildbot/bin/python'} 09:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:37 INFO - Running setup.py (path:/tmp/pip-hxRAzi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:37 INFO - Running setup.py (path:/tmp/pip-wqOo_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:37 INFO - Running setup.py (path:/tmp/pip-Ilx7M4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:37 INFO - Running setup.py (path:/tmp/pip-bxjRKt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:37 INFO - Running setup.py (path:/tmp/pip-e2Ik3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:37 INFO - Running setup.py (path:/tmp/pip-8veoGM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:37 INFO - Running setup.py (path:/tmp/pip-PmwwLp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:38 INFO - Running setup.py (path:/tmp/pip-kFsTA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:38 INFO - Running setup.py (path:/tmp/pip-kudIst-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:38 INFO - Running setup.py (path:/tmp/pip-p9pw5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:38 INFO - Running setup.py (path:/tmp/pip-7QuYKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:38 INFO - Running setup.py (path:/tmp/pip-5YD6DL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:38 INFO - Running setup.py (path:/tmp/pip-ByXHi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:38 INFO - Running setup.py (path:/tmp/pip-nMhQrz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:38 INFO - Running setup.py (path:/tmp/pip-KSfiAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:38 INFO - Running setup.py (path:/tmp/pip-tITfmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:38 INFO - Running setup.py (path:/tmp/pip-bMfBPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:38 INFO - Running setup.py install for manifestparser 09:57:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:57:38 INFO - Running setup.py install for mozcrash 09:57:38 INFO - Running setup.py install for mozdebug 09:57:39 INFO - Running setup.py install for mozdevice 09:57:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for mozfile 09:57:39 INFO - Running setup.py install for mozhttpd 09:57:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for mozinfo 09:57:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for mozInstall 09:57:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for mozleak 09:57:39 INFO - Running setup.py install for mozlog 09:57:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for moznetwork 09:57:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:57:39 INFO - Running setup.py install for mozprocess 09:57:39 INFO - Running setup.py install for mozprofile 09:57:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:57:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:57:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:57:40 INFO - Running setup.py install for mozrunner 09:57:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:57:40 INFO - Running setup.py install for mozscreenshot 09:57:40 INFO - Running setup.py install for moztest 09:57:40 INFO - Running setup.py install for mozversion 09:57:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:57:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:40 INFO - Cleaning up... 09:57:40 INFO - Return code: 0 09:57:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:40 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:40 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 09:57:40 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 09:57:40 INFO - Using env: {'DISPLAY': ':0', 09:57:40 INFO - 'HOME': '/home/cltbld', 09:57:40 INFO - 'LANG': 'en_US.UTF-8', 09:57:40 INFO - 'LANGUAGE': 'en_US:en', 09:57:40 INFO - 'LOGNAME': 'cltbld', 09:57:40 INFO - 'MAIL': '/var/mail/cltbld', 09:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:40 INFO - 'MOZ_NO_REMOTE': '1', 09:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:40 INFO - 'NO_EM_RESTART': '1', 09:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:40 INFO - 'SHELL': '/bin/bash', 09:57:40 INFO - 'SHLVL': '1', 09:57:40 INFO - 'TERM': 'linux', 09:57:40 INFO - 'TMOUT': '86400', 09:57:40 INFO - 'USER': 'cltbld', 09:57:40 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:40 INFO - '_': '/tools/buildbot/bin/python'} 09:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:40 INFO - Running setup.py (path:/tmp/pip-6bEFkW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:40 INFO - Running setup.py (path:/tmp/pip-XG0dF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:40 INFO - Running setup.py (path:/tmp/pip-lotnpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:40 INFO - Running setup.py (path:/tmp/pip-Wx6Tb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:41 INFO - Running setup.py (path:/tmp/pip-Xe1O6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:41 INFO - Running setup.py (path:/tmp/pip-of151a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:41 INFO - Running setup.py (path:/tmp/pip-J0kW6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:41 INFO - Running setup.py (path:/tmp/pip-RUyEco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:41 INFO - Running setup.py (path:/tmp/pip-SUBH61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:41 INFO - Running setup.py (path:/tmp/pip-8Fi1aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:41 INFO - Running setup.py (path:/tmp/pip-q2Kdud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:41 INFO - Running setup.py (path:/tmp/pip-qUwjSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:41 INFO - Running setup.py (path:/tmp/pip-OD60Cr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:57:41 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)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:41 INFO - Running setup.py (path:/tmp/pip-hOPKKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:41 INFO - Running setup.py (path:/tmp/pip-bLHilk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:41 INFO - Running setup.py (path:/tmp/pip-xvynvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:57:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:41 INFO - Running setup.py (path:/tmp/pip-EZjH6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:57:41 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:41 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:57:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:43 INFO - Downloading blessings-1.5.1.tar.gz 09:57:43 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 09:57:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:43 INFO - Installing collected packages: blessings 09:57:43 INFO - Running setup.py install for blessings 09:57:43 INFO - Successfully installed blessings 09:57:43 INFO - Cleaning up... 09:57:43 INFO - Return code: 0 09:57:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:57:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:44 INFO - Reading from file tmpfile_stdout 09:57:44 INFO - Current package versions: 09:57:44 INFO - argparse == 1.2.1 09:57:44 INFO - blessings == 1.5.1 09:57:44 INFO - blobuploader == 1.2.4 09:57:44 INFO - docopt == 0.6.1 09:57:44 INFO - manifestparser == 1.1 09:57:44 INFO - mozInstall == 1.12 09:57:44 INFO - mozcrash == 0.16 09:57:44 INFO - mozdebug == 0.1 09:57:44 INFO - mozdevice == 0.46 09:57:44 INFO - mozfile == 1.2 09:57:44 INFO - mozhttpd == 0.7 09:57:44 INFO - mozinfo == 0.8 09:57:44 INFO - mozleak == 0.1 09:57:44 INFO - mozlog == 3.0 09:57:44 INFO - moznetwork == 0.27 09:57:44 INFO - mozprocess == 0.22 09:57:44 INFO - mozprofile == 0.27 09:57:44 INFO - mozrunner == 6.11 09:57:44 INFO - mozscreenshot == 0.1 09:57:44 INFO - mozsystemmonitor == 0.0 09:57:44 INFO - moztest == 0.7 09:57:44 INFO - mozversion == 1.4 09:57:44 INFO - psutil == 3.1.1 09:57:44 INFO - requests == 1.2.3 09:57:44 INFO - wsgiref == 0.1.2 09:57:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:44 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:44 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 09:57:44 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 09:57:44 INFO - Using env: {'DISPLAY': ':0', 09:57:44 INFO - 'HOME': '/home/cltbld', 09:57:44 INFO - 'LANG': 'en_US.UTF-8', 09:57:44 INFO - 'LANGUAGE': 'en_US:en', 09:57:44 INFO - 'LOGNAME': 'cltbld', 09:57:44 INFO - 'MAIL': '/var/mail/cltbld', 09:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:44 INFO - 'MOZ_NO_REMOTE': '1', 09:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:44 INFO - 'NO_EM_RESTART': '1', 09:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:44 INFO - 'SHELL': '/bin/bash', 09:57:44 INFO - 'SHLVL': '1', 09:57:44 INFO - 'TERM': 'linux', 09:57:44 INFO - 'TMOUT': '86400', 09:57:44 INFO - 'USER': 'cltbld', 09:57:44 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:44 INFO - '_': '/tools/buildbot/bin/python'} 09:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 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)) 09:57:44 INFO - Cleaning up... 09:57:44 INFO - Return code: 0 09:57:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:44 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:44 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 09:57:44 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 09:57:44 INFO - Using env: {'DISPLAY': ':0', 09:57:44 INFO - 'HOME': '/home/cltbld', 09:57:44 INFO - 'LANG': 'en_US.UTF-8', 09:57:44 INFO - 'LANGUAGE': 'en_US:en', 09:57:44 INFO - 'LOGNAME': 'cltbld', 09:57:44 INFO - 'MAIL': '/var/mail/cltbld', 09:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:44 INFO - 'MOZ_NO_REMOTE': '1', 09:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:44 INFO - 'NO_EM_RESTART': '1', 09:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:44 INFO - 'SHELL': '/bin/bash', 09:57:44 INFO - 'SHLVL': '1', 09:57:44 INFO - 'TERM': 'linux', 09:57:44 INFO - 'TMOUT': '86400', 09:57:44 INFO - 'USER': 'cltbld', 09:57:44 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:44 INFO - '_': '/tools/buildbot/bin/python'} 09:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:44 INFO - Downloading/unpacking jsonschema 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:46 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 09:57:46 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:57:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:46 INFO - warning: no files found matching '*.txt' 09:57:46 INFO - no previously-included directories found matching 'build' 09:57:46 INFO - no previously-included directories found matching 'dist' 09:57:46 INFO - no previously-included directories found matching '.git*' 09:57:46 INFO - Installing collected packages: jsonschema, functools32 09:57:46 INFO - Running setup.py install for functools32 09:57:46 INFO - warning: no files found matching '*.txt' 09:57:46 INFO - no previously-included directories found matching 'build' 09:57:46 INFO - no previously-included directories found matching 'dist' 09:57:46 INFO - no previously-included directories found matching '.git*' 09:57:46 INFO - Successfully installed jsonschema functools32 09:57:46 INFO - Cleaning up... 09:57:46 INFO - Return code: 0 09:57:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:46 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 0x7fd81d9b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, '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': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:57:46 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 09:57:46 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 09:57:46 INFO - Using env: {'DISPLAY': ':0', 09:57:46 INFO - 'HOME': '/home/cltbld', 09:57:46 INFO - 'LANG': 'en_US.UTF-8', 09:57:46 INFO - 'LANGUAGE': 'en_US:en', 09:57:46 INFO - 'LOGNAME': 'cltbld', 09:57:46 INFO - 'MAIL': '/var/mail/cltbld', 09:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:46 INFO - 'MOZ_NO_REMOTE': '1', 09:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:46 INFO - 'NO_EM_RESTART': '1', 09:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:46 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:46 INFO - 'SHELL': '/bin/bash', 09:57:46 INFO - 'SHLVL': '1', 09:57:46 INFO - 'TERM': 'linux', 09:57:46 INFO - 'TMOUT': '86400', 09:57:46 INFO - 'USER': 'cltbld', 09:57:46 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:46 INFO - '_': '/tools/buildbot/bin/python'} 09:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:46 INFO - Downloading/unpacking flake8 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:48 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 09:57:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:48 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 09:57:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 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 09:57:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:57:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:49 INFO - no previously-included directories found matching 'docs/_build' 09:57:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:49 INFO - Running setup.py install for pep8 09:57:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:49 INFO - no previously-included directories found matching 'docs/_build' 09:57:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:57:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:49 INFO - Cleaning up... 09:57:49 INFO - Return code: 0 09:57:49 INFO - Running post-action listener: _resource_record_post_action 09:57:49 INFO - Running post-action listener: _start_resource_monitoring 09:57:49 INFO - Starting resource monitoring. 09:57:49 INFO - ##### 09:57:49 INFO - ##### Running install step. 09:57:49 INFO - ##### 09:57:49 INFO - Running pre-action listener: _resource_record_pre_action 09:57:49 INFO - Running main action method: install 09:57:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:57:49 INFO - Reading from file tmpfile_stdout 09:57:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:57:49 INFO - Reading from file tmpfile_stdout 09:57:49 INFO - Output received: 09:57:49 INFO - Usage: mozinstall [options] installer 09:57:49 INFO - Options: 09:57:49 INFO - -h, --help show this help message and exit 09:57:49 INFO - -d DEST, --destination=DEST 09:57:49 INFO - Directory to install application into. [default: 09:57:49 INFO - "/builds/slave/test-pgo"] 09:57:49 INFO - --app=APP Application being installed. [default: firefox] 09:57:49 INFO - mkdir: /builds/slave/test-pgo/build/application 09:57:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:58:04 INFO - Reading from file tmpfile_stdout 09:58:04 INFO - Output received: 09:58:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:58:04 INFO - Running post-action listener: _resource_record_post_action 09:58:04 INFO - ##### 09:58:04 INFO - ##### Running run-tests step. 09:58:04 INFO - ##### 09:58:04 INFO - Running pre-action listener: _resource_record_pre_action 09:58:04 INFO - Running main action method: run_tests 09:58:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:58:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:58:04 INFO - Python 2.7.3 09:58:04 INFO - Return code: 0 09:58:04 INFO - grabbing minidump binary from tooltool 09:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:58:04 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 0x117fa50>, '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 0x10eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:58:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:58:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:58:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:04 INFO - Return code: 0 09:58:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:58:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:58:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:58:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:58:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:58:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:58:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:58:05 INFO - Return code: 0 09:58:05 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/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:58:05 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/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 09:58:05 INFO - Using env: {'DISPLAY': ':0', 09:58:05 INFO - 'HOME': '/home/cltbld', 09:58:05 INFO - 'LANG': 'en_US.UTF-8', 09:58:05 INFO - 'LANGUAGE': 'en_US:en', 09:58:05 INFO - 'LOGNAME': 'cltbld', 09:58:05 INFO - 'MAIL': '/var/mail/cltbld', 09:58:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:58:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:05 INFO - 'MOZ_NO_REMOTE': '1', 09:58:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:05 INFO - 'NO_EM_RESTART': '1', 09:58:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:58:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:58:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:58:05 INFO - 'SHELL': '/bin/bash', 09:58:05 INFO - 'SHLVL': '1', 09:58:05 INFO - 'TERM': 'linux', 09:58:05 INFO - 'TMOUT': '86400', 09:58:05 INFO - 'USER': 'cltbld', 09:58:05 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252', 09:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:05 INFO - '_': '/tools/buildbot/bin/python'} 09:58:05 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/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 09:58:05 INFO - mozversion INFO | application_buildid: 20151204051719 09:58:05 INFO - mozversion INFO | application_changeset: f339f85d742e28e801b4d7c25004538efd73e2b1 09:58:05 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:58:05 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:05 INFO - mozversion INFO | application_name: Firefox 09:58:05 INFO - mozversion INFO | application_remotingname: firefox-dev 09:58:05 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:05 INFO - mozversion INFO | application_vendor: Mozilla 09:58:05 INFO - mozversion INFO | application_version: 44.0a2 09:58:05 INFO - mozversion INFO | platform_buildid: 20151204051719 09:58:05 INFO - mozversion INFO | platform_changeset: f339f85d742e28e801b4d7c25004538efd73e2b1 09:58:05 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:05 INFO - mozversion INFO | platform_version: 44.0a2 09:58:05 INFO - 2015-12-04 09:58:05,218 DEBUG : using testdate: 1449251885 09:58:05 INFO - 2015-12-04 09:58:05,218 DEBUG : actual date: 1449251885 09:58:05 INFO - 2015-12-04 09:58:05,230 INFO : starting webserver on 'localhost:43614' 09:58:05 INFO - 2015-12-04 09:58:05,231 INFO : Starting test suite talos-linux64-ix-014.e 09:58:05 INFO - 2015-12-04 09:58:05,231 INFO : Starting test dromaeo_css 09:58:05 INFO - 2015-12-04 09:58:05,231 DEBUG : operating with platform_type : linux_ 09:58:05 INFO - 2015-12-04 09:58:05,232 INFO : Initialising browser for dromaeo_css test... 09:58:05 INFO - 2015-12-04 09:58:05,246 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcPneSt/profile http://localhost:43614/getInfo.html 09:58:09 INFO - 2015-12-04 09:58:09,630 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:58:09 INFO - 2015-12-04 09:58:09,631 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:58:09 INFO - 2015-12-04 09:58:09,631 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:58:09 INFO - 2015-12-04 09:58:09,631 DEBUG : BROWSER_OUTPUT: __metrics 09:58:10 INFO - 2015-12-04 09:58:10,969 INFO : Browser initialized. 09:58:10 INFO - 2015-12-04 09:58:10,970 INFO : Running cycle 1/1 for dromaeo_css test... 09:58:10 INFO - 2015-12-04 09:58:10,970 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcPneSt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:58:22 INFO - 2015-12-04 09:58:22,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 133373952 09:58:22 INFO - 2015-12-04 09:58:22,667 DEBUG : BROWSER_OUTPUT: 09:59:12 INFO - 2015-12-04 09:59:12,299 DEBUG : BROWSER_OUTPUT: 1449251952297 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] 10:01:19 INFO - 2015-12-04 10:01:19,600 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43614/tests/dromaeo/cssquery-ext.html) 10:01:20 INFO - 2015-12-04 10:01:20,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 136777728 10:01:20 INFO - 2015-12-04 10:01:20,578 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-04 10:04:22,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-ext.html (next: http://localhost:43614/tests/dromaeo/cssquery-jquery.html) 10:04:22 INFO - 2015-12-04 10:04:22,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 136568832 10:04:22 INFO - 2015-12-04 10:04:22,885 DEBUG : BROWSER_OUTPUT: 10:07:24 INFO - 2015-12-04 10:07:24,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43614/tests/dromaeo/cssquery-mootools.html) 10:07:25 INFO - 2015-12-04 10:07:24,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 135491584 10:07:25 INFO - 2015-12-04 10:07:25,000 DEBUG : BROWSER_OUTPUT: 10:10:26 INFO - 2015-12-04 10:10:26,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43614/tests/dromaeo/cssquery-prototype.html) 10:10:27 INFO - 2015-12-04 10:10:27,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 135016448 10:10:27 INFO - 2015-12-04 10:10:27,154 DEBUG : BROWSER_OUTPUT: 10:13:29 INFO - 2015-12-04 10:13:29,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43614/tests/dromaeo/cssquery-yui.html) 10:13:29 INFO - 2015-12-04 10:13:29,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 136290304 10:13:29 INFO - 2015-12-04 10:13:29,927 DEBUG : BROWSER_OUTPUT: 10:16:31 INFO - 2015-12-04 10:16:31,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/dromaeo/cssquery-yui.html (next: http://localhost:43614/tests/dromaeo/cssquery-dojo.html) 10:16:32 INFO - 2015-12-04 10:16:32,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 137551872 10:16:32 INFO - 2015-12-04 10:16:32,056 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,056 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:16:32 INFO - 2015-12-04 10:16:32,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:16:32 INFO - 2015-12-04 10:16:32,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:16:32 INFO - 2015-12-04 10:16:32,056 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:16:32 INFO - 2015-12-04 10:16:32,058 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3294.5717056782614;3356.8825091121817;3361.7478689098325;3386.373520898634;3391.8982430527076;5554.305711786027;5566.610337276392;5571.888562228758;5576.804811831586;5582.218489411481;5511.751971161298;5515.972420137894;5529.3364796224505;5538.861528461781;5584.581156413265;5090.541851233388;5131.307273518065;5195.19474481456;5195.870103247411;5280.419153893069;4959.479254678261;5037.118504261758;5147.433782283946;5147.794088236466;5224.1902505111575;5105.3873535175835;5173.844784656466;5177.585793136559;5181.818636347729;5190.792368305263;5091.898162036776;5152.58779297659;5170.870728231786;5179.715115668656;5225.581953443715;4927.827526036572;4946.530079642428;5032.396112466491;5046.899062018739;5086.262491938648;5376.489233522809;5395.217693434469;5406.135018397077;5414.5668346532575;5419.078756611386;6003.489703375175;6063.575549711522;6081.513478921675;6088.512918966472;6089.939100608982;5800.941990580124;5950.553708471882;5962.850928726816;5972.820815375546;5976.760929562813;5536.667799932017;5618.12918997552;5629.549636029108;5636.351819540764;5672.517835983905;6073.5748497604745;6090.116933044684;6093;6100.328963813977;6102.298235702862;5797.739101740432;5946.0189068803165;5963.880722385528;5964.821055368346;5971.313298970587;6019.789307374221;6019.909701354483;6024.427679370453;6059.091136329585;6094.75620975156;6000.129981152796;6001.039833626599;6003;6023.427774361428;6023.608465449732;5894.292684877756;5914.58597898143;6028.8794224116145;6036.275646922398;6051.485623721945;4603.309503574424;4633.62930965522;4637.489876113625;4641;4656.8137274508645;4108.5275193352545;4110.712250142521;4128.277551428488;4131.338985762263;4159.168166366739;5489.862753431116;5635.746391412396;5660.518855897212;5793.015187418149;5803.332616749043;5966.164736936832;6041.78853740117;6056.242969628796;6073.665948372882;6073.8177854663545;5756.539476841843;5760.049591817387;5769.105788602773;5775.047117225611;5786.826395208151;5084.8220312288895;5154.175331946871;5196.506331898464;5315.415304316522;5327.600429967691;6206.689665516707;6246.281677607042;6247;6250;6268.905966410507;5714.79998200061;6081.513478921675;6082.817515474543;6097.4817140543555;6125.295591007091;6089.025755879038;6103.877922441615;6126.145907668675;6137.622145770902;6153.600015998945;5944.64332140073;5944.8811023780145;5955.583109182489;5960.165576819162;6053.273607167168;5835.183074369676;5956.910646340221;6026.186464827192;6028.608140470856;6039.5470339723815;5804.912926306024;5870.882582348415;5885.3820348862755;5890.646561206341;5918.970405147947;5827.679477628772;5874.353821079763;5884.146798714248;5908.320543137423;5922.703864806828;5599.048161812583;5710.400407957105;5746.281714785652;5839.036558967723;5844.736986835517;5953.821385358447;5961.986462301333;5981.551383646157;5991.910121348096;6002.129691194839;5758.568107392046;5769;5831.241938548132;5847.532197424281;5847.883042339045 10:16:32 INFO - 2015-12-04 10:16:32,061 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.1340016775173;610.4841409009387;622.2439735721099;634.8761991411676;697.1564407067448;34530.48204276935;44167;44401;44697.329540056926;44755.55244447554;46810.595682129504;47266.291005634856;47309.52690473094;47383.526164738345;47521.52478475214;9241.168294853462;9347.345685801996;9362.485063321514;9430.339876208669;9436.622535098622;9156.725298241063;9258.305627077962;9329.53352332384;9350.485723285217;9355;9262.397944133643;9380;9386.38988465751;9391.389559678599;9403.38877972933;9240.907590924106;9294.163525282724;9295.442273463546;9296.442213467213;9351.158395744347;9121.361504694674;9180.540972951392;9213;9240.214581760558;9246.0753924607;43540.78229608863;43636.345454818205;43694.78152609248;43724.12551748947;43772;3332.7167190788814;3466.445368740989;3522.9295414091575;3755.2114056048263;4185.686073544466;32597.837010814794;32780.18049548756;33026.17434564131;33497.33005339904;33568.32863342744;3971.126352202511;3986.5614782373914;3995.9400608990886;4002.699797515198;4069.857554985591;304881;306198;307584;307747;308103;58860.7056964721;59650;62902.68548657227;63347.6832615834;63367.6831615839;76705.23294767093;77807.22192778112;78026;78443.60778196073;78450;16900.91549542269;16950.745738813926;17144.485665430057;17179.31282748676;17194.398196063077;12511.311877846623;12536.561220357244;12560.874391256153;12607.432665530074;12618.55835045769;21616.567668646854;21975;21996.560068798535;22048.33854984353;22056.88971555132;7769.494982826098;7854.2145785421;7931.127575966639;7932.325752311002;8062.717804876801;880.3089574683843;984.9362688296623;997.5361456922566;1011.8684571005722;1023.8771347438355;29605;29648;29876.55185172224;30483.2379190522;30554.236144096576;1019.4087429290994;1052.7999680060764;1066.7759770448292;1116.7749524750318;1172.5485688010008;15716.13561254142;15808.288627011812;16048.438304659281;16235.431759888348;16409.343626255053;374667;391711;576843;586466;588912;55488;55540;55782.72108639431;55782.72108639512;55804.441955579925;1426.2369632246698;1443.2495102546618;1453.4476898778396;1486.8661820436212;1487.70989657018;29277;29486.981206440178;29615.111546653636;30204.84897575586;30308.393832122794;49434.25848612202;49892.25161622506;50003;50005.24992125194;50294.49705503044;312826;313269;314216;315913;317083;33896.491552626234;33899.15252118717;34096.31807363888;34216;34325.313493730486;46999.765001174776;47260.7636961813;47361;47472.52527474681;48095.75952120357;34346;34585.65414345825;36984;37535.249295014495;37774.62225377821;39133.8265764977;39246.4113038299;39448.605513945644;39800.80099599483;40301.79849100736;39248;40013;40494.59505404908;40549.1890162201;40566.59433405628;33981.83009084939;34042;34077.48883766696;34570.65429345674;34629.30741385108;26585.468290634464;26978.41008859427;27663.44673106567;27768.166954991382;28642.85678571594 10:16:32 INFO - 2015-12-04 10:16:32,062 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.39138639415717;395.07749405139;398.36858579152033;401.39589917174646;401.88546264314675;12532.373381330943;13041.67395815105;17868.55328616785;19209.039548022596;19228.807711922876;13401.731965360686;13570.932145339284;13613;13770.380332885019;14191.361388737505;4963.379577552806;4963.578095861856;5069.493050694938;5085.059264036166;5091.363579552556;3830.3105441020607;3895.6493915547594;4971.900561988776;5353.732313384316;5417.322834645669;5337.786488540453;5337.973310133444;5363.919541206885;5365.543928766059;5372.54333381661;5254.605904557174;5343.759530821103;5361.865953351158;5363.54409875161;5364.785408583652;4660.091282199973;4681.672282940195;4686.7656617169005;4686.835960741358;4697.224957881946;15455;15463.458778942795;15519;15585.688286234212;15600.60998475036;704.6159842885639;2018.5861898310811;2072.0882811563015;2075.4915045813873;2143.9616900284364;11002.614908478165;11022.228444008922;11108.722281942935;11116.888831111666;11319.320840749582;1607.802187370405;1669.090345761563;1675.4387280261128;1697.73685078813;1782.1356642028607;67786.32213677898;68447;69339;70323.2967670327;70790.95847555493;7774.727884524014;7930.206979302139;8078.838423231502;8087.919120808834;8104.230098140667;9694.321397502248;9703.805923881482;9718.562664680107;9735.367201131903;9739.26955478342;6211.223597050369;6287.7799277026;6304.306526282106;6330.145430366933;6332.556721029484;6354.809355719336;6363.3636636336;6387.201599800025;6398.2641996170105;6402.103705481236;3714.294284086015;3731.570869350005;3745.5692595351884;3753.1367785409507;3762.774233545996;1300.6033159886135;1303.485123376261;1304.2174695182814;1348.3460521646994;1361.7957306404119;489.38826466916356;513.9897202055938;514.7760724085035;548.2571116137656;555.9471850174227;13277.933610331887;13487.32563371847;13576.59270221895;13831;13910.234937078558;539.4012645962978;559.8488408129782;565.9122835960433;574.2506029631371;575.2291928815407;7206;7467.290607392289;7483.027206463125;7573.394128469709;7655.846883062308;565547;577752;578065;578486;578535;81742;81918.59040704877;85343.57328213443;85377;86418.13581864227;614.5268143529547;615.8460384903774;620.2804746494136;621.8787336469436;622.7540121651922;12401.813972790234;12561.748765024831;12673.746525069631;12769.297688626843;12794.488220471078;38707.22585548217;38913.610863891;38963;39413.802930986305;39628.40557391699;51652.70868228324;52967.73516132549;53298.73350633222;53469.7326513365;53557;7483.438742094474;7700.383969282556;7715.537067775951;7795.4543181976715;7812.53124812513;13206.933965330112;13467.3939672713;13483.932580337036;13533.188008719508;13700.314984250548;11757.706057348634;11778.116641252112;12000.399980001139;12232.633021009384;12313.13808033429;11517.25137866036;11658.125640576822;11689.240199387013;11752.11859110553;11780.293182409083;11901.10741694359;11955;11968.401579921143;12099.879001209874;12306.507739690313;7694.576798276148;7699.8075048122;7819.178986206366;7844.529328240324;7850.450468467381;11882.108841836724;12047;12367.567135150226;12567.685807854878;12671.556495522613 10:16:32 INFO - 2015-12-04 10:16:32,062 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1481.6592183797727;1482.2959094430144;1698.6687595918802;1848.0851978270757;1866.999999999999;8170.101288858221;8252.422330436872;8347.707830225936;8385.874211886827;8510.574471276426;8218.876716849252;8298.502089874597;8314.75055748327;8378.62296196671;8386.790330241747;2473.591857343536;2503.7371076037025;2509.9623505647337;2515.5472015037376;2519.8992040318367;2489.987550062256;2555.718870924197;2573.4209802794408;2575.2789219018705;2579.651747014148;2155.3210738617286;2239.305815197294;2366.1954935321987;2391.0435825669697;2435.038159926828;2327.150590034642;2355.5642206191737;2358.988205058972;2364.0189321431585;2365.66880636711;2406.855588664668;2410.843295185807;2411.770881766229;2422.9273121806373;2425.563398588253;8281.130481299497;8293.543855087968;8338.708145214889;8357.791055223608;8375.874361884577;5123.718195499246;5192.818251361185;5197.688138711652;5198.9480105198845;5212.895742085175;3294.1270563300745;3295.8681652733862;3378.35811195872;3386.6613338666184;3403.710684591788;1111.7442988112698;1120.8767035626074;1147.5811328864988;1166.8249762535602;1183.0949323767325;11143.052840508566;11269.154813388946;11277.37974411407;11293.774124517464;11378.715532111764;4558.133954548625;4563.908721825611;4612.584867361954;4613.423322084739;4627.9074418511445;9277.953610231905;9282.303827212985;9285.72142835716;9289.907100928904;9302.395344302598;5148.562372198405;5154.690718556899;5155.587552995751;5160.845174644692;5162.741862906914;4772.331873537708;4778.283257511332;4784.282357646381;4785.090832741768;4793.400824896888;3894.1432884765304;3903.316919539069;3918.921621567553;3928.4500169976227;3949.012746813297;1201.7716633839718;1211.8727533608844;1216.2276954134188;1216.5437960764714;1219.945102470391;946.394307643109;1019.1337363241333;1133.1274918313018;1249.9750004999848;1437.8634029767156;7322.434195837116;7332.9266707332245;7396.667149978264;7405.481616286808;7412.332890039815;793.8531371696255;795.4670370851543;795.8010497375656;797.2545669798757;909.554318383987;6013.278406591237;6023;6079.787207447718;6093.634381937098;6104.755809767559;9702.95148524267;9848;9918.752031199134;9919.305648604528;9948.253880958957;9579.856302155473;9733.902660973441;9832.754181145528;9853.458059806779;9865;7700.884486732703;7769.223077692185;7770.261825126604;7788.610569471503;7810.843783124419;7265.782026539212;7384;7546.056742907137;7590.430717696085;7622.123455802432;8810.427322224035;8848;8947.19475247231;8967.282617390463;9077.77305567366;8904.643814247358;8934.553272336487;8964.955175224082;9174.908250917406;9178.678746244117;7302.415806735555;7404.592747398945;7453.180150183367;7462.813429664302;7479.401647868266;7789.805254868674;7895.881561776693;7938.0077490313715;7945.523268603903;8019.91980080215;7563.7352692655495;7573.6213189341415;7605.23947605235;7617.809554761176;7718.53688778675;7461.067366579177;7516.135644400964;7523.774286771406;7604.429667774828;7617.733379331697;7525.2098529653595;7545.849083018418;7556.924430755622;7561.4706970513735;7570.735024274124;6841.24746277919;6860.211075726355;6864.313568643096;6952.895706564304;6982.441404687715;6936;6945.374916257561;6976.930230697628;6988.231294557696;7000.474964377794 10:16:32 INFO - 2015-12-04 10:16:32,064 DEBUG : BROWSER_OUTPUT: |4;prototype.html;358.16011453142374;373.7925451374487;377.5394019296458;380.03281648205314;387.271928773905;6184.041473571598;6221.253449586045;6228.377162283769;6257.249130104383;6292.182016337881;6116.327204007555;6127.540434467411;6141.293751218611;6167.938320616792;6171.382861713826;4725.196716558194;4751.762411879401;4758.143534163849;4766.7616619169075;4769.18923782956;4736.69211501253;4777.044591081798;4782.33047373368;4782.97608511957;4790.520947905216;4731.030138821533;4754.405699287589;4755.667103302771;4812.759362031902;4843.39457567804;4776.211925032366;4795.112904112751;4798.376211092553;4806.471288158317;4808.182608956486;4269.359596060584;4273;4276.700630955835;4281.186574550826;4295.463067116611;5757.884842303172;5776.624519406225;5781.219535362714;5782.959067367872;5794.985877471426;5526.447355264481;5582.553395728332;5590.580706446992;5668.31980162379;5680.0627896397045;6531.804045878631;6582.835429114262;6584.473242140617;6588.341165883373;6596.472282217459;4718.150732868083;4728.101660684459;4743.02767932573;4743.075100355432;4752.7861246244;6728;6732.259451460335;6799.218089919673;6802.591844489347;6818.624975626339;4928.260760885824;4929.112759703288;4929.580985616263;4933;4934.851954441372;4996.7001979881325;4998.525140111684;4999.525045120708;5007.048660754445;5007.148784706608;5648.548116150698;5651.519620832193;5652.293463317085;5652.97173514138;5655.462731040545;6448.677566121675;6561.311062338481;6577.243616984012;6614.768483103068;6623.966880165568;1786.5355007698092;1818.7271909213723;1820.4265656318216;1824.3523549139863;1824.352354914013;1202.7474230411538;1226.4726167747776;1232.6979889926845;1251.3805666195292;1267.714764178071;6293.496520278367;6313.810585682437;6314.210723659543;6315.5894866833505;6318.431341179224;6670.166229221348;6670.83322916931;6676.165479315086;6715.7985260442265;6766.323367663293;6286.779962701284;6336;6363.300036995926;6365.872682546323;6406.935930640727;3736.645018723217;3748.568914574859;3751.8499260029294;3779.6976241900584;3786.4888240087234;6944.652767361713;6945.89581156283;6961.512694111465;6966.198887127944;6968.721251149897;6842.178938527409;6943.236244013155;6947.79156625302;6954.860902781916;6958.617276049765;6941.68762405693;6973.721051157897;6974.686139123752;6979.336962988406;7077.186123595749;6801.421879140328;6804.76183333581;6805.9659701701175;6806.897896531457;6843.555168914005;6628.867422651423;6724.49566282521;6740.449696569718;6743.089682892747;6751.662416879235;7002.404795592432;7018.2630823762765;7025.789226323219;7043.049188359711;7073.328033836778;4678.274867395559;4682.859514214579;4711.976440117777;4718.905621887475;4720.787564559671;6648.401643852077;6757.729690812509;6763.425108865801;6783.830404239933;6832.624205668537;6563.409293163447;6583.80248592543;6585.440237579668;6586.901196481961;6595.736170553316;6615.801525954036;6617.338266173344;6622.238442578972;6623.536352455282;6625.734970601122;6376.521760868046;6425.8714825704155;6456.612603243821;6460.580062295936;6508.7721929734125;6554.213494380705;6582.736690532325;6593;6597.736090556516;6617.07360969455;6433.099366088845;6440.066190402272;6440.6135631862235;6442;6447.0329450582785 10:16:32 INFO - 2015-12-04 10:16:32,065 DEBUG : BROWSER_OUTPUT: |5;yui.html;691.2016620802974;803.7186984555407;850.7490290364342;933.5099072986682;935.7567032571529;14252.928735356321;14696.265186740673;14726.926365368172;14739.336729847157;14746.483873064459;13984.510542131027;14057.226852523132;15218.847811521882;15615.921920390381;15616.687666246668;879.1252703559967;885.402353411448;888.8000199955006;893.1648908270755;896.5651658945407;884.0673089890163;885.2210055151457;887.463084833676;888.6401007591903;892.6964831957133;908.1236606674557;908.7137551671235;910.6175406329357;913.7989642278721;915.1580545897757;902.4269588811087;903.5211337990876;903.8960519540238;904.9457032578;906.5150144672634;664.9601023938579;665.9134312539387;666.2970566052812;668.866226754651;669.4242951062083;13306.933465332611;13370.465181392732;13392.330383480885;13411.262380569065;13429.059965802398;10886.129109671287;10957.56169753209;11178.441077946152;11275.492602832892;11293.774124517464;10265.230107741874;10310.32982856112;10439.269251152422;10472.057514823702;10504.894951050544;3392.881249156292;3402.404579198655;3447.517347571342;3453.3438646657055;3504.456809194579;49393.75303123497;49590;49713.25430118551;50505;50560.24159637609;7193.388561972186;7265.2371500992695;7279.6360181990685;7285.635718214174;7344.632768361561;13205.73588528224;13257.535986240435;13265.933670331586;13298.933505332412;13301.800472992913;6674.299198584175;7000.229974702778;7031.8945215821805;7127.10911136108;7174.533655312493;4092.3452247640234;4136.255474014646;4204.285271503852;4352.7823608819435;4394.1651086293505;2924.195846142328;2940.1914473519523;2973.8513074346197;2978.3745413463416;2982.0904624089862;468.2741750287041;477.12209534456764;480;483.8064774090392;484.2252396166106;627.3475585391234;717.8384863405691;757.4962649837796;764.1327093748524;771.5756334016269;8699.782505437415;8767.342449316327;8784.253338466175;8803.735887923373;9170.81658366829;701.6526819224415;714.921358650548;732.3884556395363;741.1661880384568;764.5068930539882;4294.26997410441;4312.978435107804;4321.935170972438;4334.28484300087;4419.0940857124215;62187;62953;68369.3163068373;69135.65432172807;69501.65249173823;53771.19343209855;53972.46027539753;54303.18545221825;54837.725811370685;56269.7186514073;54871;55029.174562381595;55180.17229741557;55943.72028139833;56077;8931.553422328727;8944.150305720947;9107.043760405062;9270.44377337362;9340.859887101564;39439.408408874464;40319.193616126926;40666.186676265716;41507;41520.792396037825;47701.28448073351;50117;53318;53753;54070.459295406545;8227.629756660845;8244.093149753642;8285.62714677853;8298.460600060977;8498.915010849812;12646.683832904251;12687.302198379179;12733.29966851795;12939.5471158509;13181.340932953506;11590.362530060927;11595.130365222474;11613.187076904536;11623.825642615537;11773.47019384147;11727.88272117302;11830;11950.940245298718;12136.211146275464;12202.938985305016;10586.89413105859;11267.661970140909;11294.43527823622;11675.824862626898;11841.82237266459;10361.4301213434;10367.533460994122;10535.894641053492;10559.102476289601;10872.673819785103;9472.147506724428;9741.902580974383;9846.753831154278;10246.692599222035;10403.427811470441 10:16:32 INFO - 2015-12-04 10:16:32,065 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:16:32 INFO - 2015-12-04 10:16:32,065 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:16:32 INFO - 2015-12-04 10:16:32,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,272 10:16:32 INFO - 2015-12-04 10:16:32,065 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: __startTimestamp1449252992054__endTimestamp 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5583.61 Median:5803.33 stddev:617.34 (10.6%) stddev-sans-first:592.54 10:16:32 INFO - 2015-12-04 10:16:32,066 DEBUG : BROWSER_OUTPUT: Values: 3294.6 3356.9 3361.7 3386.4 3391.9 5554.3 5566.6 5571.9 5576.8 5582.2 5511.8 5516.0 5529.3 5538.9 5584.6 5090.5 5131.3 5195.2 5195.9 5280.4 4959.5 5037.1 5147.4 5147.8 5224.2 5105.4 5173.8 5177.6 5181.8 5190.8 5091.9 5152.6 5170.9 5179.7 5225.6 4927.8 4946.5 5032.4 5046.9 5086.3 5376.5 5395.2 5406.1 5414.6 5419.1 6003.5 6063.6 6081.5 6088.5 6089.9 5800.9 5950.6 5962.9 5972.8 5976.8 5536.7 5618.1 5629.5 5636.4 5672.5 6073.6 6090.1 6093.0 6100.3 6102.3 5797.7 5946.0 5963.9 5964.8 5971.3 6019.8 6019.9 6024.4 6059.1 6094.8 6000.1 6001.0 6003.0 6023.4 6023.6 5894.3 5914.6 6028.9 6036.3 6051.5 4603.3 4633.6 4637.5 4641.0 4656.8 4108.5 4110.7 4128.3 4131.3 4159.2 5489.9 5635.7 5660.5 5793.0 5803.3 5966.2 6041.8 6056.2 6073.7 6073.8 5756.5 5760.0 5769.1 5775.0 5786.8 5084.8 5154.2 5196.5 5315.4 5327.6 6206.7 6246.3 6247.0 6250.0 6268.9 5714.8 6081.5 6082.8 6097.5 6125.3 6089.0 6103.9 6126.1 6137.6 6153.6 5944.6 5944.9 5955.6 5960.2 6053.3 5835.2 5956.9 6026.2 6028.6 6039.5 5804.9 5870.9 5885.4 5890.6 5919.0 5827.7 5874.4 5884.1 5908.3 5922.7 5599.0 5710.4 5746.3 5839.0 5844.7 5953.8 5962.0 5981.6 5991.9 6002.1 5758.6 5769.0 5831.2 5847.5 5847.9 10:16:32 INFO - 2015-12-04 10:16:32,067 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,067 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55275.77 Median:3991.25 stddev:103371.04 (2589.9%) stddev-sans-first:103579.47 10:16:32 INFO - 2015-12-04 10:16:32,067 DEBUG : BROWSER_OUTPUT: Values: 585.1 610.5 622.2 634.9 697.2 34530.5 44167.0 44401.0 44697.3 44755.6 46810.6 47266.3 47309.5 47383.5 47521.5 9241.2 9347.3 9362.5 9430.3 9436.6 9156.7 9258.3 9329.5 9350.5 9355.0 9262.4 9380.0 9386.4 9391.4 9403.4 9240.9 9294.2 9295.4 9296.4 9351.2 9121.4 9180.5 9213.0 9240.2 9246.1 43540.8 43636.3 43694.8 43724.1 43772.0 3332.7 3466.4 3522.9 3755.2 4185.7 32597.8 32780.2 33026.2 33497.3 33568.3 3971.1 3986.6 3995.9 4002.7 4069.9 304881.0 306198.0 307584.0 307747.0 308103.0 58860.7 59650.0 62902.7 63347.7 63367.7 76705.2 77807.2 78026.0 78443.6 78450.0 16900.9 16950.7 17144.5 17179.3 17194.4 12511.3 12536.6 12560.9 12607.4 12618.6 21616.6 21975.0 21996.6 22048.3 22056.9 7769.5 7854.2 7931.1 7932.3 8062.7 880.3 984.9 997.5 1011.9 1023.9 29605.0 29648.0 29876.6 30483.2 30554.2 1019.4 1052.8 1066.8 1116.8 1172.5 15716.1 15808.3 16048.4 16235.4 16409.3 374667.0 391711.0 576843.0 586466.0 588912.0 55488.0 55540.0 55782.7 55782.7 55804.4 1426.2 1443.2 1453.4 1486.9 1487.7 29277.0 29487.0 29615.1 30204.8 30308.4 49434.3 49892.3 50003.0 50005.2 50294.5 312826.0 313269.0 314216.0 315913.0 317083.0 33896.5 33899.2 34096.3 34216.0 34325.3 46999.8 47260.8 47361.0 47472.5 48095.8 34346.0 34585.7 36984.0 37535.2 37774.6 39133.8 39246.4 39448.6 39800.8 40301.8 39248.0 40013.0 40494.6 40549.2 40566.6 33981.8 34042.0 34077.5 34570.7 34629.3 26585.5 26978.4 27663.4 27768.2 28642.9 10:16:32 INFO - 2015-12-04 10:16:32,067 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,067 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29303.00 Median:2593.31 stddev:94433.25 (3641.4%) stddev-sans-first:94673.21 10:16:32 INFO - 2015-12-04 10:16:32,068 DEBUG : BROWSER_OUTPUT: Values: 391.4 395.1 398.4 401.4 401.9 12532.4 13041.7 17868.6 19209.0 19228.8 13401.7 13570.9 13613.0 13770.4 14191.4 4963.4 4963.6 5069.5 5085.1 5091.4 3830.3 3895.6 4971.9 5353.7 5417.3 5337.8 5338.0 5363.9 5365.5 5372.5 5254.6 5343.8 5361.9 5363.5 5364.8 4660.1 4681.7 4686.8 4686.8 4697.2 15455.0 15463.5 15519.0 15585.7 15600.6 704.6 2018.6 2072.1 2075.5 2144.0 11002.6 11022.2 11108.7 11116.9 11319.3 1607.8 1669.1 1675.4 1697.7 1782.1 67786.3 68447.0 69339.0 70323.3 70791.0 7774.7 7930.2 8078.8 8087.9 8104.2 9694.3 9703.8 9718.6 9735.4 9739.3 6211.2 6287.8 6304.3 6330.1 6332.6 6354.8 6363.4 6387.2 6398.3 6402.1 3714.3 3731.6 3745.6 3753.1 3762.8 1300.6 1303.5 1304.2 1348.3 1361.8 489.4 514.0 514.8 548.3 555.9 13277.9 13487.3 13576.6 13831.0 13910.2 539.4 559.8 565.9 574.3 575.2 7206.0 7467.3 7483.0 7573.4 7655.8 565547.0 577752.0 578065.0 578486.0 578535.0 81742.0 81918.6 85343.6 85377.0 86418.1 614.5 615.8 620.3 621.9 622.8 12401.8 12561.7 12673.7 12769.3 12794.5 38707.2 38913.6 38963.0 39413.8 39628.4 51652.7 52967.7 53298.7 53469.7 53557.0 7483.4 7700.4 7715.5 7795.5 7812.5 13206.9 13467.4 13483.9 13533.2 13700.3 11757.7 11778.1 12000.4 12232.6 12313.1 11517.3 11658.1 11689.2 11752.1 11780.3 11901.1 11955.0 11968.4 12099.9 12306.5 7694.6 7699.8 7819.2 7844.5 7850.5 11882.1 12047.0 12367.6 12567.7 12671.6 10:16:32 INFO - 2015-12-04 10:16:32,068 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,069 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5802.74 Median:6979.69 stddev:2980.93 (42.7%) stddev-sans-first:2971.60 10:16:32 INFO - 2015-12-04 10:16:32,069 DEBUG : BROWSER_OUTPUT: Values: 1481.7 1482.3 1698.7 1848.1 1867.0 8170.1 8252.4 8347.7 8385.9 8510.6 8218.9 8298.5 8314.8 8378.6 8386.8 2473.6 2503.7 2510.0 2515.5 2519.9 2490.0 2555.7 2573.4 2575.3 2579.7 2155.3 2239.3 2366.2 2391.0 2435.0 2327.2 2355.6 2359.0 2364.0 2365.7 2406.9 2410.8 2411.8 2422.9 2425.6 8281.1 8293.5 8338.7 8357.8 8375.9 5123.7 5192.8 5197.7 5198.9 5212.9 3294.1 3295.9 3378.4 3386.7 3403.7 1111.7 1120.9 1147.6 1166.8 1183.1 11143.1 11269.2 11277.4 11293.8 11378.7 4558.1 4563.9 4612.6 4613.4 4627.9 9278.0 9282.3 9285.7 9289.9 9302.4 5148.6 5154.7 5155.6 5160.8 5162.7 4772.3 4778.3 4784.3 4785.1 4793.4 3894.1 3903.3 3918.9 3928.5 3949.0 1201.8 1211.9 1216.2 1216.5 1219.9 946.4 1019.1 1133.1 1250.0 1437.9 7322.4 7332.9 7396.7 7405.5 7412.3 793.9 795.5 795.8 797.3 909.6 6013.3 6023.0 6079.8 6093.6 6104.8 9703.0 9848.0 9918.8 9919.3 9948.3 9579.9 9733.9 9832.8 9853.5 9865.0 7700.9 7769.2 7770.3 7788.6 7810.8 7265.8 7384.0 7546.1 7590.4 7622.1 8810.4 8848.0 8947.2 8967.3 9077.8 8904.6 8934.6 8965.0 9174.9 9178.7 7302.4 7404.6 7453.2 7462.8 7479.4 7789.8 7895.9 7938.0 7945.5 8019.9 7563.7 7573.6 7605.2 7617.8 7718.5 7461.1 7516.1 7523.8 7604.4 7617.7 7525.2 7545.8 7556.9 7561.5 7570.7 6841.2 6860.2 6864.3 6952.9 6982.4 6936.0 6945.4 6976.9 6988.2 7000.5 10:16:32 INFO - 2015-12-04 10:16:32,069 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,069 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5542.25 Median:6292.84 stddev:1612.83 (25.6%) stddev-sans-first:1569.71 10:16:32 INFO - 2015-12-04 10:16:32,070 DEBUG : BROWSER_OUTPUT: Values: 358.2 373.8 377.5 380.0 387.3 6184.0 6221.3 6228.4 6257.2 6292.2 6116.3 6127.5 6141.3 6167.9 6171.4 4725.2 4751.8 4758.1 4766.8 4769.2 4736.7 4777.0 4782.3 4783.0 4790.5 4731.0 4754.4 4755.7 4812.8 4843.4 4776.2 4795.1 4798.4 4806.5 4808.2 4269.4 4273.0 4276.7 4281.2 4295.5 5757.9 5776.6 5781.2 5783.0 5795.0 5526.4 5582.6 5590.6 5668.3 5680.1 6531.8 6582.8 6584.5 6588.3 6596.5 4718.2 4728.1 4743.0 4743.1 4752.8 6728.0 6732.3 6799.2 6802.6 6818.6 4928.3 4929.1 4929.6 4933.0 4934.9 4996.7 4998.5 4999.5 5007.0 5007.1 5648.5 5651.5 5652.3 5653.0 5655.5 6448.7 6561.3 6577.2 6614.8 6624.0 1786.5 1818.7 1820.4 1824.4 1824.4 1202.7 1226.5 1232.7 1251.4 1267.7 6293.5 6313.8 6314.2 6315.6 6318.4 6670.2 6670.8 6676.2 6715.8 6766.3 6286.8 6336.0 6363.3 6365.9 6406.9 3736.6 3748.6 3751.8 3779.7 3786.5 6944.7 6945.9 6961.5 6966.2 6968.7 6842.2 6943.2 6947.8 6954.9 6958.6 6941.7 6973.7 6974.7 6979.3 7077.2 6801.4 6804.8 6806.0 6806.9 6843.6 6628.9 6724.5 6740.4 6743.1 6751.7 7002.4 7018.3 7025.8 7043.0 7073.3 4678.3 4682.9 4712.0 4718.9 4720.8 6648.4 6757.7 6763.4 6783.8 6832.6 6563.4 6583.8 6585.4 6586.9 6595.7 6615.8 6617.3 6622.2 6623.5 6625.7 6376.5 6425.9 6456.6 6460.6 6508.8 6554.2 6582.7 6593.0 6597.7 6617.1 6433.1 6440.1 6440.6 6442.0 6447.0 10:16:32 INFO - 2015-12-04 10:16:32,070 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,070 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14650.94 Median:49915.13 stddev:18150.75 (36.4%) stddev-sans-first:18171.40 10:16:32 INFO - 2015-12-04 10:16:32,070 DEBUG : BROWSER_OUTPUT: Values: 691.2 803.7 850.7 933.5 935.8 14252.9 14696.3 14726.9 14739.3 14746.5 13984.5 14057.2 15218.8 15615.9 15616.7 879.1 885.4 888.8 893.2 896.6 884.1 885.2 887.5 888.6 892.7 908.1 908.7 910.6 913.8 915.2 902.4 903.5 903.9 904.9 906.5 665.0 665.9 666.3 668.9 669.4 13306.9 13370.5 13392.3 13411.3 13429.1 10886.1 10957.6 11178.4 11275.5 11293.8 10265.2 10310.3 10439.3 10472.1 10504.9 3392.9 3402.4 3447.5 3453.3 3504.5 49393.8 49590.0 49713.3 50505.0 50560.2 7193.4 7265.2 7279.6 7285.6 7344.6 13205.7 13257.5 13265.9 13298.9 13301.8 6674.3 7000.2 7031.9 7127.1 7174.5 4092.3 4136.3 4204.3 4352.8 4394.2 2924.2 2940.2 2973.9 2978.4 2982.1 468.3 477.1 480.0 483.8 484.2 627.3 717.8 757.5 764.1 771.6 8699.8 8767.3 8784.3 8803.7 9170.8 701.7 714.9 732.4 741.2 764.5 4294.3 4313.0 4321.9 4334.3 4419.1 62187.0 62953.0 68369.3 69135.7 69501.7 53771.2 53972.5 54303.2 54837.7 56269.7 54871.0 55029.2 55180.2 55943.7 56077.0 8931.6 8944.2 9107.0 9270.4 9340.9 39439.4 40319.2 40666.2 41507.0 41520.8 47701.3 50117.0 53318.0 53753.0 54070.5 8227.6 8244.1 8285.6 8298.5 8498.9 12646.7 12687.3 12733.3 12939.5 13181.3 11590.4 11595.1 11613.2 11623.8 11773.5 11727.9 11830.0 11950.9 12136.2 12202.9 10586.9 11267.7 11294.4 11675.8 11841.8 10361.4 10367.5 10535.9 10559.1 10872.7 9472.1 9741.9 9846.8 10246.7 10403.4 10:16:32 INFO - 2015-12-04 10:16:32,071 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:16:32 INFO - 2015-12-04 10:16:32,071 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2015-12-04 10:16:32,701 INFO : Browser exited with error code: 0 10:16:32 INFO - 2015-12-04 10:16:32,718 INFO : Completed test dromaeo_css (00:18:27) 10:16:32 INFO - 2015-12-04 10:16:32,718 INFO : Starting test kraken 10:16:32 INFO - 2015-12-04 10:16:32,718 DEBUG : operating with platform_type : linux_ 10:16:32 INFO - 2015-12-04 10:16:32,718 INFO : Initialising browser for kraken test... 10:16:32 INFO - 2015-12-04 10:16:32,724 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHQ6mHp/profile http://localhost:43614/getInfo.html 10:16:37 INFO - 2015-12-04 10:16:37,273 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:37 INFO - 2015-12-04 10:16:37,273 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:37 INFO - 2015-12-04 10:16:37,273 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:37 INFO - 2015-12-04 10:16:37,273 DEBUG : BROWSER_OUTPUT: __metrics 10:16:38 INFO - 2015-12-04 10:16:38,329 INFO : Browser initialized. 10:16:38 INFO - 2015-12-04 10:16:38,330 INFO : Running cycle 1/1 for kraken test... 10:16:38 INFO - 2015-12-04 10:16:38,330 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHQ6mHp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:50 INFO - 2015-12-04 10:16:50,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 132747264 10:16:50 INFO - 2015-12-04 10:16:50,032 DEBUG : BROWSER_OUTPUT: 10:16:52 INFO - 2015-12-04 10:16:52,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43614/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:53 INFO - 2015-12-04 10:16:53,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 133529600 10:16:53 INFO - 2015-12-04 10:16:53,080 DEBUG : BROWSER_OUTPUT: 10:16:55 INFO - 2015-12-04 10:16:55,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43614/tests/kraken/driver.html?testName=audio-dft) 10:16:56 INFO - 2015-12-04 10:16:56,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 135352320 10:16:56 INFO - 2015-12-04 10:16:56,249 DEBUG : BROWSER_OUTPUT: 10:16:59 INFO - 2015-12-04 10:16:59,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43614/tests/kraken/driver.html?testName=audio-fft) 10:16:59 INFO - 2015-12-04 10:16:59,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 135041024 10:16:59 INFO - 2015-12-04 10:16:59,652 DEBUG : BROWSER_OUTPUT: 10:17:01 INFO - 2015-12-04 10:17:01,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43614/tests/kraken/driver.html?testName=audio-oscillator) 10:17:02 INFO - 2015-12-04 10:17:02,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 135532544 10:17:02 INFO - 2015-12-04 10:17:02,247 DEBUG : BROWSER_OUTPUT: 10:17:04 INFO - 2015-12-04 10:17:04,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:04 INFO - 2015-12-04 10:17:04,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 134979584 10:17:04 INFO - 2015-12-04 10:17:04,978 DEBUG : BROWSER_OUTPUT: 10:17:07 INFO - 2015-12-04 10:17:07,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43614/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:08 INFO - 2015-12-04 10:17:08,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 134688768 10:17:08 INFO - 2015-12-04 10:17:08,544 DEBUG : BROWSER_OUTPUT: 10:17:11 INFO - 2015-12-04 10:17:11,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43614/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:12 INFO - 2015-12-04 10:17:12,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 135393280 10:17:12 INFO - 2015-12-04 10:17:12,529 DEBUG : BROWSER_OUTPUT: 10:17:15 INFO - 2015-12-04 10:17:15,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43614/tests/kraken/driver.html?testName=json-parse-financial) 10:17:15 INFO - 2015-12-04 10:17:15,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 135716864 10:17:15 INFO - 2015-12-04 10:17:15,951 DEBUG : BROWSER_OUTPUT: 10:17:17 INFO - 2015-12-04 10:17:17,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:18 INFO - 2015-12-04 10:17:18,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 134926336 10:17:18 INFO - 2015-12-04 10:17:18,101 DEBUG : BROWSER_OUTPUT: 10:17:19 INFO - 2015-12-04 10:17:19,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:20 INFO - 2015-12-04 10:17:20,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 135778304 10:17:20 INFO - 2015-12-04 10:17:20,458 DEBUG : BROWSER_OUTPUT: 10:17:22 INFO - 2015-12-04 10:17:22,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:23 INFO - 2015-12-04 10:17:23,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 136032256 10:17:23 INFO - 2015-12-04 10:17:23,049 DEBUG : BROWSER_OUTPUT: 10:17:25 INFO - 2015-12-04 10:17:25,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:25 INFO - 2015-12-04 10:17:25,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 136220672 10:17:25 INFO - 2015-12-04 10:17:25,977 DEBUG : BROWSER_OUTPUT: 10:17:28 INFO - 2015-12-04 10:17:28,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:29 INFO - 2015-12-04 10:17:29,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 135593984 10:17:29 INFO - 2015-12-04 10:17:29,044 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43614/tests/kraken/driver.html?testName=ai-astar) 10:17:30 INFO - 2015-12-04 10:17:30,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 136675328 10:17:30 INFO - 2015-12-04 10:17:30,937 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,940 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:30 INFO - 2015-12-04 10:17:30,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:30 INFO - 2015-12-04 10:17:30,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;112;112;111;122;109;110;113;109 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;125;146;168;125;142;150;125;157;125 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;162;165;161;161;161;165;162 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;71;154;74;74;73;73;155;71 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;134;89;90;89;132;89;89;136 10:17:30 INFO - 2015-12-04 10:17:30,941 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;110;109;110;109;110 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;147;147;146;146;146 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;98;95;101;96 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;60;60;60;61;61;67;66;58;58 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;63;63;63;63;63;63;63 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;81;87;81;81;82;81;79;80 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;109;112;117;113;120;118;110;116;112 10:17:30 INFO - 2015-12-04 10:17:30,942 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;143;142;141;142;134;141;147;139;142 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;69;66;64;63;65;61;62;64;66 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,694 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: __startTimestamp1449253050938__endTimestamp 10:17:30 INFO - 2015-12-04 10:17:30,943 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,947 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:30 INFO - 2015-12-04 10:17:30,947 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:17:30 INFO - 2015-12-04 10:17:30,947 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,947 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:4.35 (3.9%) stddev-sans-first:4.61 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 112.0 112.0 111.0 122.0 109.0 110.0 113.0 109.0 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.50 stddev:15.39 (10.6%) stddev-sans-first:16.25 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: Values: 145.0 125.0 146.0 168.0 125.0 142.0 150.0 125.0 157.0 125.0 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.81 (1.1%) stddev-sans-first:1.90 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 162.0 165.0 161.0 161.0 161.0 165.0 162.0 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:73.00 stddev:34.59 (47.4%) stddev-sans-first:36.08 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 154.0 74.0 74.0 73.0 73.0 155.0 71.0 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,948 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:89.00 stddev:21.69 (24.4%) stddev-sans-first:22.44 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 134.0 89.0 90.0 89.0 132.0 89.0 89.0 136.0 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 110.0 109.0 110.0 109.0 110.0 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:1.80 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 98.0 95.0 101.0 96.0 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,949 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.00 stddev:3.06 (5.0%) stddev-sans-first:3.19 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 63.0 60.0 60.0 60.0 61.0 61.0 67.0 66.0 58.0 58.0 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.16 (2.7%) stddev-sans-first:2.29 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 81.0 87.0 81.0 81.0 82.0 81.0 79.0 80.0 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.90 Median:114.50 stddev:3.63 (3.2%) stddev-sans-first:3.79 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 112.0 109.0 112.0 117.0 113.0 120.0 118.0 110.0 116.0 112.0 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:142.00 stddev:3.26 (2.3%) stddev-sans-first:3.46 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 141.0 143.0 142.0 141.0 142.0 134.0 141.0 147.0 139.0 142.0 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.31 (3.6%) stddev-sans-first:2.40 10:17:30 INFO - 2015-12-04 10:17:30,950 DEBUG : BROWSER_OUTPUT: Values: 63.0 69.0 66.0 64.0 63.0 65.0 61.0 62.0 64.0 66.0 10:17:30 INFO - 2015-12-04 10:17:30,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:30 INFO - 2015-12-04 10:17:30,951 DEBUG : BROWSER_OUTPUT: 10:17:31 INFO - 2015-12-04 10:17:31,758 INFO : Browser exited with error code: 0 10:17:31 INFO - 2015-12-04 10:17:31,810 INFO : Completed test kraken (00:00:59) 10:17:31 INFO - 2015-12-04 10:17:31,811 INFO : Starting test v8_7 10:17:31 INFO - 2015-12-04 10:17:31,811 DEBUG : operating with platform_type : linux_ 10:17:31 INFO - 2015-12-04 10:17:31,811 INFO : Initialising browser for v8_7 test... 10:17:31 INFO - 2015-12-04 10:17:31,817 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVAtH4d/profile http://localhost:43614/getInfo.html 10:17:36 INFO - 2015-12-04 10:17:36,168 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:36 INFO - 2015-12-04 10:17:36,169 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:36 INFO - 2015-12-04 10:17:36,169 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:17:36 INFO - 2015-12-04 10:17:36,169 DEBUG : BROWSER_OUTPUT: __metrics 10:17:37 INFO - 2015-12-04 10:17:37,165 INFO : Browser initialized. 10:17:37 INFO - 2015-12-04 10:17:37,166 INFO : Running cycle 1/1 for v8_7 test... 10:17:37 INFO - 2015-12-04 10:17:37,166 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVAtH4d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:17:48 INFO - 2015-12-04 10:17:48,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 133378048 10:17:48 INFO - 2015-12-04 10:17:48,875 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43614/tests/v8_7/run.html (next: http://localhost:43614/tests/v8_7/run.html) 10:18:10 INFO - 2015-12-04 10:18:10,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 131653632 10:18:10 INFO - 2015-12-04 10:18:10,486 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: |0;Richards;163.18537859007833 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.11567419575633 10:18:10 INFO - 2015-12-04 10:18:10,487 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |4;RayTrace;913.2420091324201 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |5;Earley;562.1135469364812 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |6;Boyer;10437.5 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |7;RegExp;23604.6511627907 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |8;Splay;530.2226935312831 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: __startTimestamp1449253090479__endTimestamp 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,488 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.19 Median:163.19 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: Values: 163.2 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.12 Median:171.12 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: Values: 171.1 10:18:10 INFO - 2015-12-04 10:18:10,489 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: Values: 279.6 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: Values: 5000.0 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:913.24 Median:913.24 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,490 DEBUG : BROWSER_OUTPUT: Values: 913.2 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:562.11 Median:562.11 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: Values: 562.1 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10437.50 Median:10437.50 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: Values: 10437.5 10:18:10 INFO - 2015-12-04 10:18:10,491 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23604.65 Median:23604.65 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: Values: 23604.7 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:530.22 Median:530.22 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: Values: 530.2 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:18:10 INFO - 2015-12-04 10:18:10,492 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:18:10 INFO - 2015-12-04 10:18:10,493 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:10 INFO - 2015-12-04 10:18:10,493 DEBUG : BROWSER_OUTPUT: 10:18:11 INFO - 2015-12-04 10:18:11,334 INFO : Browser exited with error code: 0 10:18:11 INFO - 2015-12-04 10:18:11,350 INFO : Completed test v8_7 (00:00:39) 10:18:11 INFO - 2015-12-04 10:18:11,537 INFO : Completed test suite (00:20:06) 10:18:11 INFO - 2015-12-04 10:18:11,537 DEBUG : Working with test: dromaeo_css 10:18:11 INFO - 2015-12-04 10:18:11,537 DEBUG : Generating results file: dromaeo_css 10:18:11 INFO - 2015-12-04 10:18:11,538 DEBUG : Working with test: kraken 10:18:11 INFO - 2015-12-04 10:18:11,538 DEBUG : Generating results file: kraken 10:18:11 INFO - 2015-12-04 10:18:11,539 INFO : javascript benchmark 10:18:11 INFO - 2015-12-04 10:18:11,539 DEBUG : Working with test: v8_7 10:18:11 INFO - 2015-12-04 10:18:11,539 DEBUG : Generating results file: v8_7 10:18:11 INFO - 2015-12-04 10:18:11,539 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:11 INFO - 2015-12-04 10:18:11,604 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:18:11 INFO - 2015-12-04 10:18:11,604 DEBUG : process_Request line: dromaeo_css 7126.13 graph.html#tests=[[72,52,43]] 10:18:11 INFO - 2015-12-04 10:18:11,604 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:11 INFO - 2015-12-04 10:18:11,639 DEBUG : process_Request line: kraken 1483.50 graph.html#tests=[[232,52,43]] 10:18:11 INFO - 2015-12-04 10:18:11,639 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:11 INFO - 2015-12-04 10:18:11,692 DEBUG : process_Request line: v8_7 23394.22 graph.html#tests=[[230,52,43]] 10:18:11 INFO - 2015-12-04 10:18:11,694 INFO : javascript benchmark 10:18:11 INFO - 2015-12-04 10:18:11,697 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3294.5717056782614, 3356.8825091121817, 3361.7478689098325, 3386.373520898634, 3391.8982430527076, 5554.305711786027, 5566.610337276392, 5571.888562228758, 5576.804811831586, 5582.218489411481, 5511.751971161298, 5515.972420137894, 5529.3364796224505, 5538.861528461781, 5584.581156413265, 5090.541851233388, 5131.307273518065, 5195.19474481456, 5195.870103247411, 5280.419153893069, 4959.479254678261, 5037.118504261758, 5147.433782283946, 5147.794088236466, 5224.1902505111575, 5105.3873535175835, 5173.844784656466, 5177.585793136559, 5181.818636347729, 5190.792368305263, 5091.898162036776, 5152.58779297659, 5170.870728231786, 5179.715115668656, 5225.581953443715, 4927.827526036572, 4946.530079642428, 5032.396112466491, 5046.899062018739, 5086.262491938648, 5376.489233522809, 5395.217693434469, 5406.135018397077, 5414.5668346532575, 5419.078756611386, 6003.489703375175, 6063.575549711522, 6081.513478921675, 6088.512918966472, 6089.939100608982, 5800.941990580124, 5950.553708471882, 5962.850928726816, 5972.820815375546, 5976.760929562813, 5536.667799932017, 5618.12918997552, 5629.549636029108, 5636.351819540764, 5672.517835983905, 6073.5748497604745, 6090.116933044684, 6093.0, 6100.328963813977, 6102.298235702862, 5797.739101740432, 5946.0189068803165, 5963.880722385528, 5964.821055368346, 5971.313298970587, 6019.789307374221, 6019.909701354483, 6024.427679370453, 6059.091136329585, 6094.75620975156, 6000.129981152796, 6001.039833626599, 6003.0, 6023.427774361428, 6023.608465449732, 5894.292684877756, 5914.58597898143, 6028.8794224116145, 6036.275646922398, 6051.485623721945, 4603.309503574424, 4633.62930965522, 4637.489876113625, 4641.0, 4656.8137274508645, 4108.5275193352545, 4110.712250142521, 4128.277551428488, 4131.338985762263, 4159.168166366739, 5489.862753431116, 5635.746391412396, 5660.518855897212, 5793.015187418149, 5803.332616749043, 5966.164736936832, 6041.78853740117, 6056.242969628796, 6073.665948372882, 6073.8177854663545, 5756.539476841843, 5760.049591817387, 5769.105788602773, 5775.047117225611, 5786.826395208151, 5084.8220312288895, 5154.175331946871, 5196.506331898464, 5315.415304316522, 5327.600429967691, 6206.689665516707, 6246.281677607042, 6247.0, 6250.0, 6268.905966410507, 5714.79998200061, 6081.513478921675, 6082.817515474543, 6097.4817140543555, 6125.295591007091, 6089.025755879038, 6103.877922441615, 6126.145907668675, 6137.622145770902, 6153.600015998945, 5944.64332140073, 5944.8811023780145, 5955.583109182489, 5960.165576819162, 6053.273607167168, 5835.183074369676, 5956.910646340221, 6026.186464827192, 6028.608140470856, 6039.5470339723815, 5804.912926306024, 5870.882582348415, 5885.3820348862755, 5890.646561206341, 5918.970405147947, 5827.679477628772, 5874.353821079763, 5884.146798714248, 5908.320543137423, 5922.703864806828, 5599.048161812583, 5710.400407957105, 5746.281714785652, 5839.036558967723, 5844.736986835517, 5953.821385358447, 5961.986462301333, 5981.551383646157, 5991.910121348096, 6002.129691194839, 5758.568107392046, 5769.0, 5831.241938548132, 5847.532197424281, 5847.883042339045], "unit": "ms", "name": "dojo.html", "value": 5543.665851543293}, {"lowerIsBetter": false, "replicates": [585.1340016775173, 610.4841409009387, 622.2439735721099, 634.8761991411676, 697.1564407067448, 34530.48204276935, 44167.0, 44401.0, 44697.329540056926, 44755.55244447554, 46810.595682129504, 47266.291005634856, 47309.52690473094, 47383.526164738345, 47521.52478475214, 9241.168294853462, 9347.345685801996, 9362.485063321514, 9430.339876208669, 9436.622535098622, 9156.725298241063, 9258.305627077962, 9329.53352332384, 9350.485723285217, 9355.0, 9262.397944133643, 9380.0, 9386.38988465751, 9391.389559678599, 9403.38877972933, 9240.907590924106, 9294.163525282724, 9295.442273463546, 9296.442213467213, 9351.158395744347, 9121.361504694674, 9180.540972951392, 9213.0, 9240.214581760558, 9246.0753924607, 43540.78229608863, 43636.345454818205, 43694.78152609248, 43724.12551748947, 43772.0, 3332.7167190788814, 3466.445368740989, 3522.9295414091575, 3755.2114056048263, 4185.686073544466, 32597.837010814794, 32780.18049548756, 33026.17434564131, 33497.33005339904, 33568.32863342744, 3971.126352202511, 3986.5614782373914, 3995.9400608990886, 4002.699797515198, 4069.857554985591, 304881.0, 306198.0, 307584.0, 307747.0, 308103.0, 58860.7056964721, 59650.0, 62902.68548657227, 63347.6832615834, 63367.6831615839, 76705.23294767093, 77807.22192778112, 78026.0, 78443.60778196073, 78450.0, 16900.91549542269, 16950.745738813926, 17144.485665430057, 17179.31282748676, 17194.398196063077, 12511.311877846623, 12536.561220357244, 12560.874391256153, 12607.432665530074, 12618.55835045769, 21616.567668646854, 21975.0, 21996.560068798535, 22048.33854984353, 22056.88971555132, 7769.494982826098, 7854.2145785421, 7931.127575966639, 7932.325752311002, 8062.717804876801, 880.3089574683843, 984.9362688296623, 997.5361456922566, 1011.8684571005722, 1023.8771347438355, 29605.0, 29648.0, 29876.55185172224, 30483.2379190522, 30554.236144096576, 1019.4087429290994, 1052.7999680060764, 1066.7759770448292, 1116.7749524750318, 1172.5485688010008, 15716.13561254142, 15808.288627011812, 16048.438304659281, 16235.431759888348, 16409.343626255053, 374667.0, 391711.0, 576843.0, 586466.0, 588912.0, 55488.0, 55540.0, 55782.72108639431, 55782.72108639512, 55804.441955579925, 1426.2369632246698, 1443.2495102546618, 1453.4476898778396, 1486.8661820436212, 1487.70989657018, 29277.0, 29486.981206440178, 29615.111546653636, 30204.84897575586, 30308.393832122794, 49434.25848612202, 49892.25161622506, 50003.0, 50005.24992125194, 50294.49705503044, 312826.0, 313269.0, 314216.0, 315913.0, 317083.0, 33896.491552626234, 33899.15252118717, 34096.31807363888, 34216.0, 34325.313493730486, 46999.765001174776, 47260.7636961813, 47361.0, 47472.52527474681, 48095.75952120357, 34346.0, 34585.65414345825, 36984.0, 37535.249295014495, 37774.62225377821, 39133.8265764977, 39246.4113038299, 39448.605513945644, 39800.80099599483, 40301.79849100736, 39248.0, 40013.0, 40494.59505404908, 40549.1890162201, 40566.59433405628, 33981.83009084939, 34042.0, 34077.48883766696, 34570.65429345674, 34629.30741385108, 26585.468290634464, 26978.41008859427, 27663.44673106567, 27768.166954991382, 28642.85678571594], "unit": "ms", "name": "ext.html", "value": 20141.66465261253}, {"lowerIsBetter": false, "replicates": [391.39138639415717, 395.07749405139, 398.36858579152033, 401.39589917174646, 401.88546264314675, 12532.373381330943, 13041.67395815105, 17868.55328616785, 19209.039548022596, 19228.807711922876, 13401.731965360686, 13570.932145339284, 13613.0, 13770.380332885019, 14191.361388737505, 4963.379577552806, 4963.578095861856, 5069.493050694938, 5085.059264036166, 5091.363579552556, 3830.3105441020607, 3895.6493915547594, 4971.900561988776, 5353.732313384316, 5417.322834645669, 5337.786488540453, 5337.973310133444, 5363.919541206885, 5365.543928766059, 5372.54333381661, 5254.605904557174, 5343.759530821103, 5361.865953351158, 5363.54409875161, 5364.785408583652, 4660.091282199973, 4681.672282940195, 4686.7656617169005, 4686.835960741358, 4697.224957881946, 15455.0, 15463.458778942795, 15519.0, 15585.688286234212, 15600.60998475036, 704.6159842885639, 2018.5861898310811, 2072.0882811563015, 2075.4915045813873, 2143.9616900284364, 11002.614908478165, 11022.228444008922, 11108.722281942935, 11116.888831111666, 11319.320840749582, 1607.802187370405, 1669.090345761563, 1675.4387280261128, 1697.73685078813, 1782.1356642028607, 67786.32213677898, 68447.0, 69339.0, 70323.2967670327, 70790.95847555493, 7774.727884524014, 7930.206979302139, 8078.838423231502, 8087.919120808834, 8104.230098140667, 9694.321397502248, 9703.805923881482, 9718.562664680107, 9735.367201131903, 9739.26955478342, 6211.223597050369, 6287.7799277026, 6304.306526282106, 6330.145430366933, 6332.556721029484, 6354.809355719336, 6363.3636636336, 6387.201599800025, 6398.2641996170105, 6402.103705481236, 3714.294284086015, 3731.570869350005, 3745.5692595351884, 3753.1367785409507, 3762.774233545996, 1300.6033159886135, 1303.485123376261, 1304.2174695182814, 1348.3460521646994, 1361.7957306404119, 489.38826466916356, 513.9897202055938, 514.7760724085035, 548.2571116137656, 555.9471850174227, 13277.933610331887, 13487.32563371847, 13576.59270221895, 13831.0, 13910.234937078558, 539.4012645962978, 559.8488408129782, 565.9122835960433, 574.2506029631371, 575.2291928815407, 7206.0, 7467.290607392289, 7483.027206463125, 7573.394128469709, 7655.846883062308, 565547.0, 577752.0, 578065.0, 578486.0, 578535.0, 81742.0, 81918.59040704877, 85343.57328213443, 85377.0, 86418.13581864227, 614.5268143529547, 615.8460384903774, 620.2804746494136, 621.8787336469436, 622.7540121651922, 12401.813972790234, 12561.748765024831, 12673.746525069631, 12769.297688626843, 12794.488220471078, 38707.22585548217, 38913.610863891, 38963.0, 39413.802930986305, 39628.40557391699, 51652.70868228324, 52967.73516132549, 53298.73350633222, 53469.7326513365, 53557.0, 7483.438742094474, 7700.383969282556, 7715.537067775951, 7795.4543181976715, 7812.53124812513, 13206.933965330112, 13467.3939672713, 13483.932580337036, 13533.188008719508, 13700.314984250548, 11757.706057348634, 11778.116641252112, 12000.399980001139, 12232.633021009384, 12313.13808033429, 11517.25137866036, 11658.125640576822, 11689.240199387013, 11752.11859110553, 11780.293182409083, 11901.10741694359, 11955.0, 11968.401579921143, 12099.879001209874, 12306.507739690313, 7694.576798276148, 7699.8075048122, 7819.178986206366, 7844.529328240324, 7850.450468467381, 11882.108841836724, 12047.0, 12367.567135150226, 12567.685807854878, 12671.556495522613], "unit": "ms", "name": "jquery.html", "value": 7645.722292989887}, {"lowerIsBetter": false, "replicates": [1481.6592183797727, 1482.2959094430144, 1698.6687595918802, 1848.0851978270757, 1866.999999999999, 8170.101288858221, 8252.422330436872, 8347.707830225936, 8385.874211886827, 8510.574471276426, 8218.876716849252, 8298.502089874597, 8314.75055748327, 8378.62296196671, 8386.790330241747, 2473.591857343536, 2503.7371076037025, 2509.9623505647337, 2515.5472015037376, 2519.8992040318367, 2489.987550062256, 2555.718870924197, 2573.4209802794408, 2575.2789219018705, 2579.651747014148, 2155.3210738617286, 2239.305815197294, 2366.1954935321987, 2391.0435825669697, 2435.038159926828, 2327.150590034642, 2355.5642206191737, 2358.988205058972, 2364.0189321431585, 2365.66880636711, 2406.855588664668, 2410.843295185807, 2411.770881766229, 2422.9273121806373, 2425.563398588253, 8281.130481299497, 8293.543855087968, 8338.708145214889, 8357.791055223608, 8375.874361884577, 5123.718195499246, 5192.818251361185, 5197.688138711652, 5198.9480105198845, 5212.895742085175, 3294.1270563300745, 3295.8681652733862, 3378.35811195872, 3386.6613338666184, 3403.710684591788, 1111.7442988112698, 1120.8767035626074, 1147.5811328864988, 1166.8249762535602, 1183.0949323767325, 11143.052840508566, 11269.154813388946, 11277.37974411407, 11293.774124517464, 11378.715532111764, 4558.133954548625, 4563.908721825611, 4612.584867361954, 4613.423322084739, 4627.9074418511445, 9277.953610231905, 9282.303827212985, 9285.72142835716, 9289.907100928904, 9302.395344302598, 5148.562372198405, 5154.690718556899, 5155.587552995751, 5160.845174644692, 5162.741862906914, 4772.331873537708, 4778.283257511332, 4784.282357646381, 4785.090832741768, 4793.400824896888, 3894.1432884765304, 3903.316919539069, 3918.921621567553, 3928.4500169976227, 3949.012746813297, 1201.7716633839718, 1211.8727533608844, 1216.2276954134188, 1216.5437960764714, 1219.945102470391, 946.394307643109, 1019.1337363241333, 1133.1274918313018, 1249.9750004999848, 1437.8634029767156, 7322.434195837116, 7332.9266707332245, 7396.667149978264, 7405.481616286808, 7412.332890039815, 793.8531371696255, 795.4670370851543, 795.8010497375656, 797.2545669798757, 909.554318383987, 6013.278406591237, 6023.0, 6079.787207447718, 6093.634381937098, 6104.755809767559, 9702.95148524267, 9848.0, 9918.752031199134, 9919.305648604528, 9948.253880958957, 9579.856302155473, 9733.902660973441, 9832.754181145528, 9853.458059806779, 9865.0, 7700.884486732703, 7769.223077692185, 7770.261825126604, 7788.610569471503, 7810.843783124419, 7265.782026539212, 7384.0, 7546.056742907137, 7590.430717696085, 7622.123455802432, 8810.427322224035, 8848.0, 8947.19475247231, 8967.282617390463, 9077.77305567366, 8904.643814247358, 8934.553272336487, 8964.955175224082, 9174.908250917406, 9178.678746244117, 7302.415806735555, 7404.592747398945, 7453.180150183367, 7462.813429664302, 7479.401647868266, 7789.805254868674, 7895.881561776693, 7938.0077490313715, 7945.523268603903, 8019.91980080215, 7563.7352692655495, 7573.6213189341415, 7605.23947605235, 7617.809554761176, 7718.53688778675, 7461.067366579177, 7516.135644400964, 7523.774286771406, 7604.429667774828, 7617.733379331697, 7525.2098529653595, 7545.849083018418, 7556.924430755622, 7561.4706970513735, 7570.735024274124, 6841.24746277919, 6860.211075726355, 6864.313568643096, 6952.895706564304, 6982.441404687715, 6936.0, 6945.374916257561, 6976.930230697628, 6988.231294557696, 7000.474964377794], "unit": "ms", "name": "mootools.html", "value": 4741.775765387212}, {"lowerIsBetter": false, "replicates": [358.16011453142374, 373.7925451374487, 377.5394019296458, 380.03281648205314, 387.271928773905, 6184.041473571598, 6221.253449586045, 6228.377162283769, 6257.249130104383, 6292.182016337881, 6116.327204007555, 6127.540434467411, 6141.293751218611, 6167.938320616792, 6171.382861713826, 4725.196716558194, 4751.762411879401, 4758.143534163849, 4766.7616619169075, 4769.18923782956, 4736.69211501253, 4777.044591081798, 4782.33047373368, 4782.97608511957, 4790.520947905216, 4731.030138821533, 4754.405699287589, 4755.667103302771, 4812.759362031902, 4843.39457567804, 4776.211925032366, 4795.112904112751, 4798.376211092553, 4806.471288158317, 4808.182608956486, 4269.359596060584, 4273.0, 4276.700630955835, 4281.186574550826, 4295.463067116611, 5757.884842303172, 5776.624519406225, 5781.219535362714, 5782.959067367872, 5794.985877471426, 5526.447355264481, 5582.553395728332, 5590.580706446992, 5668.31980162379, 5680.0627896397045, 6531.804045878631, 6582.835429114262, 6584.473242140617, 6588.341165883373, 6596.472282217459, 4718.150732868083, 4728.101660684459, 4743.02767932573, 4743.075100355432, 4752.7861246244, 6728.0, 6732.259451460335, 6799.218089919673, 6802.591844489347, 6818.624975626339, 4928.260760885824, 4929.112759703288, 4929.580985616263, 4933.0, 4934.851954441372, 4996.7001979881325, 4998.525140111684, 4999.525045120708, 5007.048660754445, 5007.148784706608, 5648.548116150698, 5651.519620832193, 5652.293463317085, 5652.97173514138, 5655.462731040545, 6448.677566121675, 6561.311062338481, 6577.243616984012, 6614.768483103068, 6623.966880165568, 1786.5355007698092, 1818.7271909213723, 1820.4265656318216, 1824.3523549139863, 1824.352354914013, 1202.7474230411538, 1226.4726167747776, 1232.6979889926845, 1251.3805666195292, 1267.714764178071, 6293.496520278367, 6313.810585682437, 6314.210723659543, 6315.5894866833505, 6318.431341179224, 6670.166229221348, 6670.83322916931, 6676.165479315086, 6715.7985260442265, 6766.323367663293, 6286.779962701284, 6336.0, 6363.300036995926, 6365.872682546323, 6406.935930640727, 3736.645018723217, 3748.568914574859, 3751.8499260029294, 3779.6976241900584, 3786.4888240087234, 6944.652767361713, 6945.89581156283, 6961.512694111465, 6966.198887127944, 6968.721251149897, 6842.178938527409, 6943.236244013155, 6947.79156625302, 6954.860902781916, 6958.617276049765, 6941.68762405693, 6973.721051157897, 6974.686139123752, 6979.336962988406, 7077.186123595749, 6801.421879140328, 6804.76183333581, 6805.9659701701175, 6806.897896531457, 6843.555168914005, 6628.867422651423, 6724.49566282521, 6740.449696569718, 6743.089682892747, 6751.662416879235, 7002.404795592432, 7018.2630823762765, 7025.789226323219, 7043.049188359711, 7073.328033836778, 4678.274867395559, 4682.859514214579, 4711.976440117777, 4718.905621887475, 4720.787564559671, 6648.401643852077, 6757.729690812509, 6763.425108865801, 6783.830404239933, 6832.624205668537, 6563.409293163447, 6583.80248592543, 6585.440237579668, 6586.901196481961, 6595.736170553316, 6615.801525954036, 6617.338266173344, 6622.238442578972, 6623.536352455282, 6625.734970601122, 6376.521760868046, 6425.8714825704155, 6456.612603243821, 6460.580062295936, 6508.7721929734125, 6554.213494380705, 6582.736690532325, 6593.0, 6597.736090556516, 6617.07360969455, 6433.099366088845, 6440.066190402272, 6440.6135631862235, 6442.0, 6447.0329450582785], "unit": "ms", "name": "prototype.html", "value": 5035.136176693375}, {"lowerIsBetter": false, "replicates": [691.2016620802974, 803.7186984555407, 850.7490290364342, 933.5099072986682, 935.7567032571529, 14252.928735356321, 14696.265186740673, 14726.926365368172, 14739.336729847157, 14746.483873064459, 13984.510542131027, 14057.226852523132, 15218.847811521882, 15615.921920390381, 15616.687666246668, 879.1252703559967, 885.402353411448, 888.8000199955006, 893.1648908270755, 896.5651658945407, 884.0673089890163, 885.2210055151457, 887.463084833676, 888.6401007591903, 892.6964831957133, 908.1236606674557, 908.7137551671235, 910.6175406329357, 913.7989642278721, 915.1580545897757, 902.4269588811087, 903.5211337990876, 903.8960519540238, 904.9457032578, 906.5150144672634, 664.9601023938579, 665.9134312539387, 666.2970566052812, 668.866226754651, 669.4242951062083, 13306.933465332611, 13370.465181392732, 13392.330383480885, 13411.262380569065, 13429.059965802398, 10886.129109671287, 10957.56169753209, 11178.441077946152, 11275.492602832892, 11293.774124517464, 10265.230107741874, 10310.32982856112, 10439.269251152422, 10472.057514823702, 10504.894951050544, 3392.881249156292, 3402.404579198655, 3447.517347571342, 3453.3438646657055, 3504.456809194579, 49393.75303123497, 49590.0, 49713.25430118551, 50505.0, 50560.24159637609, 7193.388561972186, 7265.2371500992695, 7279.6360181990685, 7285.635718214174, 7344.632768361561, 13205.73588528224, 13257.535986240435, 13265.933670331586, 13298.933505332412, 13301.800472992913, 6674.299198584175, 7000.229974702778, 7031.8945215821805, 7127.10911136108, 7174.533655312493, 4092.3452247640234, 4136.255474014646, 4204.285271503852, 4352.7823608819435, 4394.1651086293505, 2924.195846142328, 2940.1914473519523, 2973.8513074346197, 2978.3745413463416, 2982.0904624089862, 468.2741750287041, 477.12209534456764, 480.0, 483.8064774090392, 484.2252396166106, 627.3475585391234, 717.8384863405691, 757.4962649837796, 764.1327093748524, 771.5756334016269, 8699.782505437415, 8767.342449316327, 8784.253338466175, 8803.735887923373, 9170.81658366829, 701.6526819224415, 714.921358650548, 732.3884556395363, 741.1661880384568, 764.5068930539882, 4294.26997410441, 4312.978435107804, 4321.935170972438, 4334.28484300087, 4419.0940857124215, 62187.0, 62953.0, 68369.3163068373, 69135.65432172807, 69501.65249173823, 53771.19343209855, 53972.46027539753, 54303.18545221825, 54837.725811370685, 56269.7186514073, 54871.0, 55029.174562381595, 55180.17229741557, 55943.72028139833, 56077.0, 8931.553422328727, 8944.150305720947, 9107.043760405062, 9270.44377337362, 9340.859887101564, 39439.408408874464, 40319.193616126926, 40666.186676265716, 41507.0, 41520.792396037825, 47701.28448073351, 50117.0, 53318.0, 53753.0, 54070.459295406545, 8227.629756660845, 8244.093149753642, 8285.62714677853, 8298.460600060977, 8498.915010849812, 12646.683832904251, 12687.302198379179, 12733.29966851795, 12939.5471158509, 13181.340932953506, 11590.362530060927, 11595.130365222474, 11613.187076904536, 11623.825642615537, 11773.47019384147, 11727.88272117302, 11830.0, 11950.940245298718, 12136.211146275464, 12202.938985305016, 10586.89413105859, 11267.661970140909, 11294.43527823622, 11675.824862626898, 11841.82237266459, 10361.4301213434, 10367.533460994122, 10535.894641053492, 10559.102476289601, 10872.673819785103, 9472.147506724428, 9741.902580974383, 9846.753831154278, 10246.692599222035, 10403.427811470441], "unit": "ms", "name": "yui.html", "value": 6424.231305904439}], "name": "dromaeo_css", "value": 7126.125514226097}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 112.0, 111.0, 122.0, 109.0, 110.0, 113.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [145.0, 125.0, 146.0, 168.0, 125.0, 142.0, 150.0, 125.0, 157.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 162.0, 165.0, 161.0, 161.0, 161.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 154.0, 74.0, 74.0, 73.0, 73.0, 155.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 134.0, 89.0, 90.0, 89.0, 132.0, 89.0, 89.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 95.0, 101.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 60.0, 60.0, 61.0, 61.0, 67.0, 66.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 61.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.1}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 81.0, 87.0, 81.0, 81.0, 82.0, 81.0, 79.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 117.0, 113.0, 120.0, 118.0, 110.0, 116.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.9}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 142.0, 141.0, 142.0, 134.0, 141.0, 147.0, 139.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [63.0, 69.0, 66.0, 64.0, 63.0, 65.0, 61.0, 62.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1483.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.18537859007833], "unit": "score", "name": "Richards", "value": 216.33065600000006}, {"lowerIsBetter": false, "replicates": [171.11567419575633], "unit": "score", "name": "DeltaBlue", "value": 386.39359199999996}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [913.2420091324201], "unit": "score", "name": "RayTrace", "value": 810.2879549999998}, {"lowerIsBetter": false, "replicates": [562.1135469364812], "unit": "score", "name": "Earley", "value": 1185.6376769999997}, {"lowerIsBetter": false, "replicates": [10437.5], "unit": "score", "name": "Boyer", "value": 63.85274251497008}, {"lowerIsBetter": false, "replicates": [23604.6511627907], "unit": "score", "name": "RegExp", "value": 38.593453201970455}, {"lowerIsBetter": false, "replicates": [530.2226935312831], "unit": "score", "name": "Splay", "value": 153.69202600000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23394.220653989287}]} 10:18:11 INFO - RETURN: dromaeo_css: 7126.13 10:18:11 INFO - RETURN: kraken: 1483.50 10:18:11 INFO - RETURN: v8_7: 23394.22 10:18:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23394.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1483.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7126.13"}}} 10:18:11 INFO - Return code: 0 10:18:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:11 INFO - # TBPL SUCCESS # 10:18:11 INFO - Running post-action listener: _resource_record_post_action 10:18:11 INFO - Running post-run listener: _resource_record_post_run 10:18:12 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 500682752; Read time: 0; Write time: 651720 10:18:12 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238100480; Read time: 0; Write time: 464692 10:18:12 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 262582272; Read time: 0; Write time: 187028 10:18:12 INFO - Running post-run listener: _upload_blobber_files 10:18:12 INFO - Blob upload gear active. 10:18:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:18:12 INFO - Copying logs to upload dir... 10:18:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.926682 ========= master_lag: 1.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-12-04 10:18:13.457506) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 10:18:13.462534) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009950 build_url: 'https://queue.taskcluster.net/v1/task/RWYrlmRKSUa9kGbZ-HUrhA/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 10:18:13.490658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:18:13.491126) ========= 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=01deea79d00cc2c334834894000001d2-1449251835.892376-2062124252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004685 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 10:18:13.541483) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 10:18:13.541834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 10:18:13.542169) ========= ========= Total master_lag: 1.29 =========