builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1447988045.52 results: success (0) buildid: 20151119163047 builduid: cc6e0095a1ce4717ba6218942eaa8552 revision: cc325db44f6f8a58604d60b746c140e73f3d8216 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.516083) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.516965) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.517262) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007927 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.549561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.549929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.582339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.582605) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.634732) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.635043) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.635449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.635783) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 18:54:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2015-11-19 18:54:07 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.226431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.874281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.874596) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019742 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.924463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:05.924877) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc325db44f6f8a58604d60b746c140e73f3d8216 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cc325db44f6f8a58604d60b746c140e73f3d8216 --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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 18:54:07,152 truncating revision to first 12 chars 2015-11-19 18:54:07,152 Setting DEBUG logging. 2015-11-19 18:54:07,152 attempt 1/10 2015-11-19 18:54:07,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc325db44f6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 18:54:07,428 unpacking tar archive at: mozilla-central-cc325db44f6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:06.518374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:06.518695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:06.527168) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:06.527541) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 18:54:06.528003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2015-11-19 18:54:06.528288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:54:07 INFO - MultiFileLogger online at 20151119 18:54:07 in /builds/slave/test-pgo 18:54:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:54:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:54:07 INFO - {'append_to_log': False, 18:54:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:54:07 INFO - 'blob_upload_branch': 'Firefox', 18:54:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:54:07 INFO - 'branch': 'Firefox', 18:54:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:54:07 INFO - 'config_files': ('talos/linux_config.py',), 18:54:07 INFO - 'default_actions': ('clobber', 18:54:07 INFO - 'read-buildbot-config', 18:54:07 INFO - 'download-and-extract', 18:54:07 INFO - 'populate-webroot', 18:54:07 INFO - 'create-virtualenv', 18:54:07 INFO - 'install', 18:54:07 INFO - 'run-tests'), 18:54:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:54:07 INFO - 'download_minidump_stackwalk': True, 18:54:07 INFO - 'download_symbols': 'ondemand', 18:54:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:54:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:54:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:54:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:54:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:54:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:54:07 INFO - 'installer_path': 'installer.exe', 18:54:07 INFO - 'log_level': 'info', 18:54:07 INFO - 'log_name': 'talos', 18:54:07 INFO - 'log_to_console': True, 18:54:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:54:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:54:07 INFO - 'opt_config_files': (), 18:54:07 INFO - 'pip_index': False, 18:54:07 INFO - 'sps_profile': False, 18:54:07 INFO - 'sps_profile_interval': 0, 18:54:07 INFO - 'suite': 'dromaeojs-e10s', 18:54:07 INFO - 'system_bits': '64', 18:54:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:54:07 INFO - 'title': 'talos-linux64-ix-025', 18:54:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:54:07 INFO - 'use_talos_json': True, 18:54:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:54:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:54:07 INFO - 'work_dir': 'build'} 18:54:07 INFO - ##### 18:54:07 INFO - ##### Running clobber step. 18:54:07 INFO - ##### 18:54:07 INFO - Running pre-action listener: _resource_record_pre_action 18:54:07 INFO - Running main action method: clobber 18:54:07 INFO - rmtree: /builds/slave/test-pgo/build 18:54:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:54:08 INFO - Running post-action listener: _resource_record_post_action 18:54:08 INFO - ##### 18:54:08 INFO - ##### Running read-buildbot-config step. 18:54:08 INFO - ##### 18:54:08 INFO - Running pre-action listener: _resource_record_pre_action 18:54:08 INFO - Running main action method: read_buildbot_config 18:54:08 INFO - Using buildbot properties: 18:54:08 INFO - { 18:54:08 INFO - "properties": { 18:54:08 INFO - "buildnumber": 250, 18:54:08 INFO - "product": "firefox", 18:54:08 INFO - "script_repo_revision": "production", 18:54:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:54:08 INFO - "repository": "", 18:54:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:54:08 INFO - "buildid": "20151119163047", 18:54:08 INFO - "slavename": "talos-linux64-ix-025", 18:54:08 INFO - "pgo_build": "True", 18:54:08 INFO - "basedir": "/builds/slave/test-pgo", 18:54:08 INFO - "project": "", 18:54:08 INFO - "platform": "ubuntu64_hw", 18:54:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:54:08 INFO - "slavebuilddir": "test", 18:54:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:54:08 INFO - "branch": "mozilla-central", 18:54:08 INFO - "repo_path": "mozilla-central", 18:54:08 INFO - "stage_platform": "linux64-pgo", 18:54:08 INFO - "builduid": "cc6e0095a1ce4717ba6218942eaa8552", 18:54:08 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 18:54:08 INFO - }, 18:54:08 INFO - "sourcestamp": { 18:54:08 INFO - "repository": "", 18:54:08 INFO - "hasPatch": false, 18:54:08 INFO - "project": "", 18:54:08 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:54:08 INFO - "changes": [ 18:54:08 INFO - { 18:54:08 INFO - "category": null, 18:54:08 INFO - "files": [ 18:54:08 INFO - { 18:54:08 INFO - "url": null, 18:54:08 INFO - "name": "https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:54:08 INFO - } 18:54:08 INFO - ], 18:54:08 INFO - "repository": "", 18:54:08 INFO - "rev": "cc325db44f6f8a58604d60b746c140e73f3d8216", 18:54:08 INFO - "who": "sendchange", 18:54:08 INFO - "when": 1447987969, 18:54:08 INFO - "number": 6686513, 18:54:08 INFO - "comments": "", 18:54:08 INFO - "project": "", 18:54:08 INFO - "at": "Thu 19 Nov 2015 18:52:49", 18:54:08 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:54:08 INFO - "revlink": "", 18:54:08 INFO - "properties": [ 18:54:08 INFO - [ 18:54:08 INFO - "buildid", 18:54:08 INFO - "20151119163047", 18:54:08 INFO - "Change" 18:54:08 INFO - ], 18:54:08 INFO - [ 18:54:08 INFO - "builduid", 18:54:08 INFO - "cc6e0095a1ce4717ba6218942eaa8552", 18:54:08 INFO - "Change" 18:54:08 INFO - ], 18:54:08 INFO - [ 18:54:08 INFO - "pgo_build", 18:54:08 INFO - "True", 18:54:08 INFO - "Change" 18:54:08 INFO - ] 18:54:08 INFO - ], 18:54:08 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 18:54:08 INFO - } 18:54:08 INFO - ], 18:54:08 INFO - "revision": "cc325db44f6f8a58604d60b746c140e73f3d8216" 18:54:08 INFO - } 18:54:08 INFO - } 18:54:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:54:08 INFO - Running post-action listener: _resource_record_post_action 18:54:08 INFO - ##### 18:54:08 INFO - ##### Running download-and-extract step. 18:54:08 INFO - ##### 18:54:08 INFO - Running pre-action listener: _resource_record_pre_action 18:54:08 INFO - Running main action method: download_and_extract 18:54:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:54:08 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')]} 18:54:08 INFO - https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:54:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/test_packages.json 18:54:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/test_packages.json 18:54:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:54:17 INFO - Downloaded 1302 bytes. 18:54:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:54:17 INFO - Using the following test package requirements: 18:54:17 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:17 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:54:17 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'jsshell-linux-x86_64.zip'], 18:54:17 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:54:17 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:17 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:54:17 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:54:17 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:54:17 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:54:17 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:54:17 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:54:17 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:54:17 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')]} 18:54:17 INFO - https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:48 INFO - Downloaded 22520897 bytes. 18:54:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:54:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:54:49 INFO - Return code: 0 18:54:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:54:49 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')]} 18:54:49 INFO - https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:54:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:54:50 INFO - Downloaded 22520897 bytes. 18:54:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:54:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:54:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:54:51 INFO - Return code: 0 18:54:51 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')]} 18:54:51 INFO - https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:54:58 INFO - Downloaded 11130997 bytes. 18:54:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:54:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:54:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:54:58 INFO - Return code: 0 18:54:58 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')]} 18:54:58 INFO - https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:00 INFO - Downloaded 57345520 bytes. 18:55:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:00 INFO - mkdir: /builds/slave/test-pgo/properties 18:55:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:55:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:55:00 INFO - Contents: 18:55:00 INFO - build_url:https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:55:00 INFO - Running post-action listener: _resource_record_post_action 18:55:00 INFO - Running post-action listener: set_extra_try_arguments 18:55:00 INFO - ##### 18:55:00 INFO - ##### Running populate-webroot step. 18:55:00 INFO - ##### 18:55:00 INFO - Running pre-action listener: _resource_record_pre_action 18:55:00 INFO - Running main action method: populate_webroot 18:55:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:55:00 INFO - '../fennec_ids.txt'], 18:55:00 INFO - 'tests': ['tcheck2']}, 18:55:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:00 INFO - '--tppagecycles', 18:55:00 INFO - '7'], 18:55:00 INFO - 'tests': ['tsvgm']}}, 18:55:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:55:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:55:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:55:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'tests': ['damp', 'tps']}, 18:55:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['damp', 'tps']}, 18:55:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:55:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:00 INFO - 'other': {'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'other_l64': {'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'other_nol64': {'tests': ['a11yr', 18:55:00 INFO - 'ts_paint', 18:55:00 INFO - 'tpaint', 18:55:00 INFO - 'sessionrestore', 18:55:00 INFO - 'sessionrestore_no_auto_restore']}, 18:55:00 INFO - 'svgr': {'tests': ['tsvgx', 18:55:00 INFO - 'tsvgr_opacity', 18:55:00 INFO - 'tart', 18:55:00 INFO - 'tscrollx', 18:55:00 INFO - 'cart']}, 18:55:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['tsvgx', 18:55:00 INFO - 'tsvgr_opacity', 18:55:00 INFO - 'tart', 18:55:00 INFO - 'tscrollx', 18:55:00 INFO - 'cart']}, 18:55:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'tests': ['tp5o']}, 18:55:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'talos_options': ['--e10s'], 18:55:00 INFO - 'tests': ['tp5o']}, 18:55:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'talos_options': ['--xperf_path', 18:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:00 INFO - 'tests': ['tp5n']}, 18:55:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:00 INFO - 'talos_options': ['--e10s', 18:55:00 INFO - '--xperf_path', 18:55:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:00 INFO - 'tests': ['tp5n']}}, 18:55:00 INFO - 'talos.zip': {'path': '', 18:55:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:00 INFO - Running post-action listener: _resource_record_post_action 18:55:00 INFO - ##### 18:55:00 INFO - ##### Running create-virtualenv step. 18:55:00 INFO - ##### 18:55:00 INFO - Running pre-action listener: _resource_record_pre_action 18:55:00 INFO - Running main action method: create_virtualenv 18:55:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:55:00 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 18:55:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:55:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:00 INFO - Using real prefix '/usr' 18:55:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:55:00 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:02 INFO - Installing pip.................done. 18:55:02 INFO - Return code: 0 18:55:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:02 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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:02 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 18:55:02 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 18:55:02 INFO - Using env: {'DISPLAY': ':0', 18:55:02 INFO - 'HOME': '/home/cltbld', 18:55:02 INFO - 'LANG': 'en_US.UTF-8', 18:55:02 INFO - 'LANGUAGE': 'en_US:en', 18:55:02 INFO - 'LOGNAME': 'cltbld', 18:55:02 INFO - 'MAIL': '/var/mail/cltbld', 18:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:02 INFO - 'MOZ_NO_REMOTE': '1', 18:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:02 INFO - 'NO_EM_RESTART': '1', 18:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:02 INFO - 'SHELL': '/bin/bash', 18:55:02 INFO - 'SHLVL': '1', 18:55:02 INFO - 'TERM': 'linux', 18:55:02 INFO - 'TMOUT': '86400', 18:55:02 INFO - 'USER': 'cltbld', 18:55:02 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:02 INFO - '_': '/tools/buildbot/bin/python'} 18:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:03 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 18:55:03 INFO - Cleaning up... 18:55:03 INFO - Return code: 0 18:55:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:55:03 INFO - Using env: {'DISPLAY': ':0', 18:55:03 INFO - 'HOME': '/home/cltbld', 18:55:03 INFO - 'LANG': 'en_US.UTF-8', 18:55:03 INFO - 'LANGUAGE': 'en_US:en', 18:55:03 INFO - 'LOGNAME': 'cltbld', 18:55:03 INFO - 'MAIL': '/var/mail/cltbld', 18:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:03 INFO - 'MOZ_NO_REMOTE': '1', 18:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:03 INFO - 'NO_EM_RESTART': '1', 18:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:03 INFO - 'SHELL': '/bin/bash', 18:55:03 INFO - 'SHLVL': '1', 18:55:03 INFO - 'TERM': 'linux', 18:55:03 INFO - 'TMOUT': '86400', 18:55:03 INFO - 'USER': 'cltbld', 18:55:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:03 INFO - '_': '/tools/buildbot/bin/python'} 18:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:03 INFO - Downloading/unpacking psutil>=0.7.1 18:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:55:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:05 INFO - Installing collected packages: psutil 18:55:05 INFO - Running setup.py install for psutil 18:55:05 INFO - building 'psutil._psutil_linux' extension 18:55:05 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 18:55:05 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 18:55:05 INFO - building 'psutil._psutil_posix' extension 18:55:05 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 18:55:05 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 18:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:05 INFO - Successfully installed psutil 18:55:05 INFO - Cleaning up... 18:55:05 INFO - Return code: 0 18:55:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:05 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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:05 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 18:55:05 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 18:55:05 INFO - Using env: {'DISPLAY': ':0', 18:55:05 INFO - 'HOME': '/home/cltbld', 18:55:05 INFO - 'LANG': 'en_US.UTF-8', 18:55:05 INFO - 'LANGUAGE': 'en_US:en', 18:55:05 INFO - 'LOGNAME': 'cltbld', 18:55:05 INFO - 'MAIL': '/var/mail/cltbld', 18:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:05 INFO - 'MOZ_NO_REMOTE': '1', 18:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:05 INFO - 'NO_EM_RESTART': '1', 18:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:05 INFO - 'SHELL': '/bin/bash', 18:55:05 INFO - 'SHLVL': '1', 18:55:05 INFO - 'TERM': 'linux', 18:55:05 INFO - 'TMOUT': '86400', 18:55:05 INFO - 'USER': 'cltbld', 18:55:05 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:05 INFO - '_': '/tools/buildbot/bin/python'} 18:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:55:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:55:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:55:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:55:07 INFO - Installing collected packages: mozsystemmonitor 18:55:07 INFO - Running setup.py install for mozsystemmonitor 18:55:07 INFO - Successfully installed mozsystemmonitor 18:55:07 INFO - Cleaning up... 18:55:07 INFO - Return code: 0 18:55:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:55:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:55:07 INFO - Using env: {'DISPLAY': ':0', 18:55:07 INFO - 'HOME': '/home/cltbld', 18:55:07 INFO - 'LANG': 'en_US.UTF-8', 18:55:07 INFO - 'LANGUAGE': 'en_US:en', 18:55:07 INFO - 'LOGNAME': 'cltbld', 18:55:07 INFO - 'MAIL': '/var/mail/cltbld', 18:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:07 INFO - 'MOZ_NO_REMOTE': '1', 18:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:07 INFO - 'NO_EM_RESTART': '1', 18:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:07 INFO - 'SHELL': '/bin/bash', 18:55:07 INFO - 'SHLVL': '1', 18:55:07 INFO - 'TERM': 'linux', 18:55:07 INFO - 'TMOUT': '86400', 18:55:07 INFO - 'USER': 'cltbld', 18:55:07 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:07 INFO - '_': '/tools/buildbot/bin/python'} 18:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:09 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:55:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:55:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:55:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:55:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:55:10 INFO - Downloading docopt-0.6.1.tar.gz 18:55:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:55:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:55:10 INFO - Installing collected packages: blobuploader, requests, docopt 18:55:10 INFO - Running setup.py install for blobuploader 18:55:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:55:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:55:10 INFO - Running setup.py install for requests 18:55:10 INFO - Running setup.py install for docopt 18:55:10 INFO - Successfully installed blobuploader requests docopt 18:55:10 INFO - Cleaning up... 18:55:10 INFO - Return code: 0 18:55:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:55:10 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')]} 18:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:10 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')]} 18:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:10 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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:10 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 18:55:10 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 18:55:10 INFO - Using env: {'DISPLAY': ':0', 18:55:10 INFO - 'HOME': '/home/cltbld', 18:55:10 INFO - 'LANG': 'en_US.UTF-8', 18:55:10 INFO - 'LANGUAGE': 'en_US:en', 18:55:10 INFO - 'LOGNAME': 'cltbld', 18:55:10 INFO - 'MAIL': '/var/mail/cltbld', 18:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:10 INFO - 'MOZ_NO_REMOTE': '1', 18:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:10 INFO - 'NO_EM_RESTART': '1', 18:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:10 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:10 INFO - 'SHELL': '/bin/bash', 18:55:10 INFO - 'SHLVL': '1', 18:55:10 INFO - 'TERM': 'linux', 18:55:10 INFO - 'TMOUT': '86400', 18:55:10 INFO - 'USER': 'cltbld', 18:55:10 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:10 INFO - '_': '/tools/buildbot/bin/python'} 18:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:11 INFO - Running setup.py (path:/tmp/pip-u2pmb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:11 INFO - Running setup.py (path:/tmp/pip-IPkKQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:11 INFO - Running setup.py (path:/tmp/pip-CgVrZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:11 INFO - Running setup.py (path:/tmp/pip-G1kQzW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:55:11 INFO - Running setup.py (path:/tmp/pip-kp1dfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:11 INFO - Running setup.py (path:/tmp/pip-luGN92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:11 INFO - Running setup.py (path:/tmp/pip-dIafyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:11 INFO - Running setup.py (path:/tmp/pip-4L3Hfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:55:11 INFO - Running setup.py (path:/tmp/pip-kARWZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:55:11 INFO - Running setup.py (path:/tmp/pip-P13Vbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:11 INFO - Running setup.py (path:/tmp/pip-eV3MFl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:11 INFO - Running setup.py (path:/tmp/pip-XN8T2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:12 INFO - Running setup.py (path:/tmp/pip-iIKd_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:12 INFO - Running setup.py (path:/tmp/pip-caMA5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:12 INFO - Running setup.py (path:/tmp/pip-v2VdAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:55:12 INFO - Running setup.py (path:/tmp/pip-JfqFZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:55:12 INFO - Running setup.py (path:/tmp/pip-soU9jx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:55:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:55:12 INFO - Running setup.py install for manifestparser 18:55:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:55:12 INFO - Running setup.py install for mozcrash 18:55:12 INFO - Running setup.py install for mozdebug 18:55:12 INFO - Running setup.py install for mozdevice 18:55:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:55:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:55:12 INFO - Running setup.py install for mozfile 18:55:12 INFO - Running setup.py install for mozhttpd 18:55:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:55:12 INFO - Running setup.py install for mozinfo 18:55:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for mozInstall 18:55:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for mozleak 18:55:13 INFO - Running setup.py install for mozlog 18:55:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for moznetwork 18:55:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for mozprocess 18:55:13 INFO - Running setup.py install for mozprofile 18:55:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for mozrunner 18:55:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:55:13 INFO - Running setup.py install for mozscreenshot 18:55:13 INFO - Running setup.py install for moztest 18:55:14 INFO - Running setup.py install for mozversion 18:55:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:55:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:55:14 INFO - Cleaning up... 18:55:14 INFO - Return code: 0 18:55:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:14 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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:14 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 18:55:14 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 18:55:14 INFO - Using env: {'DISPLAY': ':0', 18:55:14 INFO - 'HOME': '/home/cltbld', 18:55:14 INFO - 'LANG': 'en_US.UTF-8', 18:55:14 INFO - 'LANGUAGE': 'en_US:en', 18:55:14 INFO - 'LOGNAME': 'cltbld', 18:55:14 INFO - 'MAIL': '/var/mail/cltbld', 18:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:14 INFO - 'MOZ_NO_REMOTE': '1', 18:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:14 INFO - 'NO_EM_RESTART': '1', 18:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:14 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:14 INFO - 'SHELL': '/bin/bash', 18:55:14 INFO - 'SHLVL': '1', 18:55:14 INFO - 'TERM': 'linux', 18:55:14 INFO - 'TMOUT': '86400', 18:55:14 INFO - 'USER': 'cltbld', 18:55:14 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:14 INFO - '_': '/tools/buildbot/bin/python'} 18:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:14 INFO - Running setup.py (path:/tmp/pip-D1GEIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:14 INFO - Running setup.py (path:/tmp/pip-VyOFNk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:14 INFO - Running setup.py (path:/tmp/pip-0KcZej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:14 INFO - Running setup.py (path:/tmp/pip-UWa4Eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:55:14 INFO - Running setup.py (path:/tmp/pip-IOiqhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:14 INFO - Running setup.py (path:/tmp/pip-jkx4fB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:14 INFO - Running setup.py (path:/tmp/pip-Fw8tUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:14 INFO - Running setup.py (path:/tmp/pip-TwyHxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:55:14 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)) 18:55:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:55:14 INFO - Running setup.py (path:/tmp/pip-mAFjtv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:55:15 INFO - Running setup.py (path:/tmp/pip-uaXMjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:15 INFO - Running setup.py (path:/tmp/pip-tVrDPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:15 INFO - Running setup.py (path:/tmp/pip-1c5Zt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:15 INFO - Running setup.py (path:/tmp/pip-kpvR5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:15 INFO - Running setup.py (path:/tmp/pip-Ok2fs9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:15 INFO - Running setup.py (path:/tmp/pip-Qnv6Hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:55:15 INFO - Running setup.py (path:/tmp/pip-rtT4cW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:55:15 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)) 18:55:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:55:15 INFO - Running setup.py (path:/tmp/pip-MRc3Dp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:55:15 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)) 18:55:15 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)) 18:55:15 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)) 18:55:15 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)) 18:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:55:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:55:15 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 18:55:15 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 18:55:15 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 18:55:15 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 18:55:15 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 18:55:15 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 18:55:17 INFO - Downloading blessings-1.5.1.tar.gz 18:55:17 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 18:55:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:55:17 INFO - Installing collected packages: blessings 18:55:17 INFO - Running setup.py install for blessings 18:55:17 INFO - Successfully installed blessings 18:55:17 INFO - Cleaning up... 18:55:17 INFO - Return code: 0 18:55:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:55:17 INFO - Reading from file tmpfile_stdout 18:55:17 INFO - Current package versions: 18:55:17 INFO - argparse == 1.2.1 18:55:17 INFO - blessings == 1.5.1 18:55:17 INFO - blobuploader == 1.2.4 18:55:17 INFO - docopt == 0.6.1 18:55:17 INFO - manifestparser == 1.1 18:55:17 INFO - mozInstall == 1.12 18:55:17 INFO - mozcrash == 0.16 18:55:17 INFO - mozdebug == 0.1 18:55:17 INFO - mozdevice == 0.47 18:55:17 INFO - mozfile == 1.2 18:55:17 INFO - mozhttpd == 0.7 18:55:17 INFO - mozinfo == 0.9 18:55:17 INFO - mozleak == 0.1 18:55:17 INFO - mozlog == 3.0 18:55:17 INFO - moznetwork == 0.27 18:55:17 INFO - mozprocess == 0.22 18:55:17 INFO - mozprofile == 0.27 18:55:17 INFO - mozrunner == 6.11 18:55:17 INFO - mozscreenshot == 0.1 18:55:17 INFO - mozsystemmonitor == 0.0 18:55:17 INFO - moztest == 0.7 18:55:17 INFO - mozversion == 1.4 18:55:17 INFO - psutil == 3.1.1 18:55:17 INFO - requests == 1.2.3 18:55:17 INFO - wsgiref == 0.1.2 18:55:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:55:17 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')]} 18:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:17 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')]} 18:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:17 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 0x7f533e0f4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaf6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe706e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, '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': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', '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 18:55:17 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 18:55:17 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 18:55:17 INFO - Using env: {'DISPLAY': ':0', 18:55:17 INFO - 'HOME': '/home/cltbld', 18:55:17 INFO - 'LANG': 'en_US.UTF-8', 18:55:17 INFO - 'LANGUAGE': 'en_US:en', 18:55:17 INFO - 'LOGNAME': 'cltbld', 18:55:17 INFO - 'MAIL': '/var/mail/cltbld', 18:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:17 INFO - 'MOZ_NO_REMOTE': '1', 18:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:17 INFO - 'NO_EM_RESTART': '1', 18:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:17 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:17 INFO - 'SHELL': '/bin/bash', 18:55:17 INFO - 'SHLVL': '1', 18:55:17 INFO - 'TERM': 'linux', 18:55:17 INFO - 'TMOUT': '86400', 18:55:17 INFO - 'USER': 'cltbld', 18:55:17 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:17 INFO - '_': '/tools/buildbot/bin/python'} 18:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 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)) 18:55:17 INFO - Cleaning up... 18:55:17 INFO - Return code: 0 18:55:17 INFO - Running post-action listener: _resource_record_post_action 18:55:17 INFO - Running post-action listener: _start_resource_monitoring 18:55:17 INFO - Starting resource monitoring. 18:55:17 INFO - ##### 18:55:17 INFO - ##### Running install step. 18:55:17 INFO - ##### 18:55:17 INFO - Running pre-action listener: _resource_record_pre_action 18:55:17 INFO - Running main action method: install 18:55:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:55:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:55:18 INFO - Reading from file tmpfile_stdout 18:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 18:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:55:18 INFO - Reading from file tmpfile_stdout 18:55:18 INFO - Output received: 18:55:18 INFO - Usage: mozinstall [options] installer 18:55:18 INFO - Options: 18:55:18 INFO - -h, --help show this help message and exit 18:55:18 INFO - -d DEST, --destination=DEST 18:55:18 INFO - Directory to install application into. [default: 18:55:18 INFO - "/builds/slave/test-pgo"] 18:55:18 INFO - --app=APP Application being installed. [default: firefox] 18:55:18 INFO - mkdir: /builds/slave/test-pgo/build/application 18:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:55:32 INFO - Reading from file tmpfile_stdout 18:55:32 INFO - Output received: 18:55:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:55:32 INFO - Running post-action listener: _resource_record_post_action 18:55:32 INFO - ##### 18:55:32 INFO - ##### Running run-tests step. 18:55:32 INFO - ##### 18:55:32 INFO - Running pre-action listener: _resource_record_pre_action 18:55:32 INFO - Running main action method: run_tests 18:55:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:55:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:55:32 INFO - Python 2.7.3 18:55:32 INFO - Return code: 0 18:55:32 INFO - grabbing minidump binary from tooltool 18:55: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')]} 18:55:32 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 0xea6a90>, '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 0xef8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef92e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:55:32 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 18:55:32 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 18:55:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:32 INFO - Return code: 0 18:55:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:55:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:55:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:55:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:55:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:55:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:55:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 18:55:32 INFO - Using env: {'DISPLAY': ':0', 18:55:32 INFO - 'HOME': '/home/cltbld', 18:55:32 INFO - 'LANG': 'en_US.UTF-8', 18:55:32 INFO - 'LANGUAGE': 'en_US:en', 18:55:32 INFO - 'LOGNAME': 'cltbld', 18:55:32 INFO - 'MAIL': '/var/mail/cltbld', 18:55:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:55:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:32 INFO - 'MOZ_NO_REMOTE': '1', 18:55:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:32 INFO - 'NO_EM_RESTART': '1', 18:55:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:55:32 INFO - 'PWD': '/builds/slave/test-pgo', 18:55:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:55:32 INFO - 'SHELL': '/bin/bash', 18:55:32 INFO - 'SHLVL': '1', 18:55:32 INFO - 'TERM': 'linux', 18:55:32 INFO - 'TMOUT': '86400', 18:55:32 INFO - 'USER': 'cltbld', 18:55:32 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1447978710.946339-1240195199', 18:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:32 INFO - '_': '/tools/buildbot/bin/python'} 18:55:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 18:55:32 INFO - mozversion INFO | application_buildid: 20151119163047 18:55:32 INFO - mozversion INFO | application_changeset: cc325db44f6f8a58604d60b746c140e73f3d8216 18:55:32 INFO - mozversion INFO | application_display_name: Nightly 18:55:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:32 INFO - mozversion INFO | application_name: Firefox 18:55:32 INFO - mozversion INFO | application_remotingname: firefox 18:55:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:55:32 INFO - mozversion INFO | application_vendor: Mozilla 18:55:32 INFO - mozversion INFO | application_version: 45.0a1 18:55:32 INFO - mozversion INFO | platform_buildid: 20151119163047 18:55:32 INFO - mozversion INFO | platform_changeset: cc325db44f6f8a58604d60b746c140e73f3d8216 18:55:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:55:32 INFO - mozversion INFO | platform_version: 45.0a1 18:55:32 INFO - 2015-11-19 18:55:32,984 DEBUG : using testdate: 1447988132 18:55:32 INFO - 2015-11-19 18:55:32,984 DEBUG : actual date: 1447988132 18:55:33 INFO - 2015-11-19 18:55:33,059 INFO : starting webserver on 'localhost:51401' 18:55:33 INFO - 2015-11-19 18:55:33,060 INFO : Starting test suite talos-linux64-ix-025.e 18:55:33 INFO - 2015-11-19 18:55:33,060 INFO : Starting test dromaeo_css 18:55:33 INFO - 2015-11-19 18:55:33,060 DEBUG : operating with platform_type : linux_ 18:55:33 INFO - 2015-11-19 18:55:33,061 INFO : Initialising browser for dromaeo_css test... 18:55:33 INFO - 2015-11-19 18:55:33,077 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkiozb9/profile http://localhost:51401/getInfo.html 18:55:39 INFO - 2015-11-19 18:55:39,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:55:39 INFO - 2015-11-19 18:55:39,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:55:39 INFO - 2015-11-19 18:55:39,172 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:55:39 INFO - 2015-11-19 18:55:39,172 DEBUG : BROWSER_OUTPUT: __metrics 18:55:40 INFO - 2015-11-19 18:55:40,338 INFO : Browser initialized. 18:55:40 INFO - 2015-11-19 18:55:40,338 INFO : Running cycle 1/1 for dromaeo_css test... 18:55:40 INFO - 2015-11-19 18:55:40,338 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkiozb9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:55:52 INFO - 2015-11-19 18:55:52,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 142106624 18:55:52 INFO - 2015-11-19 18:55:52,131 DEBUG : BROWSER_OUTPUT: 18:56:41 INFO - 2015-11-19 18:56:41,767 DEBUG : BROWSER_OUTPUT: 1447988201767 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] 18:58:50 INFO - 2015-11-19 18:58:50,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51401/tests/dromaeo/cssquery-ext.html) 18:58:51 INFO - 2015-11-19 18:58:51,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 147525632 18:58:51 INFO - 2015-11-19 18:58:51,766 DEBUG : BROWSER_OUTPUT: 19:01:53 INFO - 2015-11-19 19:01:53,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-ext.html (next: http://localhost:51401/tests/dromaeo/cssquery-jquery.html) 19:01:54 INFO - 2015-11-19 19:01:54,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 19:01:54 INFO - 2015-11-19 19:01:54,257 DEBUG : BROWSER_OUTPUT: 19:04:55 INFO - 2015-11-19 19:04:55,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51401/tests/dromaeo/cssquery-mootools.html) 19:04:56 INFO - 2015-11-19 19:04:56,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 142721024 19:04:56 INFO - 2015-11-19 19:04:56,535 DEBUG : BROWSER_OUTPUT: 19:07:58 INFO - 2015-11-19 19:07:58,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51401/tests/dromaeo/cssquery-prototype.html) 19:07:58 INFO - 2015-11-19 19:07:58,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 19:07:58 INFO - 2015-11-19 19:07:58,782 DEBUG : BROWSER_OUTPUT: 19:11:01 INFO - 2015-11-19 19:11:01,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51401/tests/dromaeo/cssquery-yui.html) 19:11:01 INFO - 2015-11-19 19:11:01,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 142172160 19:11:01 INFO - 2015-11-19 19:11:01,721 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/dromaeo/cssquery-yui.html (next: http://localhost:51401/tests/dromaeo/cssquery-dojo.html) 19:14:04 INFO - 2015-11-19 19:14:04,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 144424960 19:14:04 INFO - 2015-11-19 19:14:04,310 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,311 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:14:04 INFO - 2015-11-19 19:14:04,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:14:04 INFO - 2015-11-19 19:14:04,311 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:14:04 INFO - 2015-11-19 19:14:04,311 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:14:04 INFO - 2015-11-19 19:14:04,312 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3190.5214217867315;3249.285157265402;3275.8689652413905;3282.474804031354;3315.4529502632076;5278.313819203508;5387.218853266274;5439.673619582828;5441.755121019559;5446.673199608022;5403.972980135104;5454.836354909349;5461.208124821898;5493.423190564993;5504.972475137619;4661.230896902007;4900.460949295574;5080.517350851663;5100.362454693163;5100.464451232623;4890.73100979446;5063.316452278932;5082;5143.742812859361;5170.870728231786;4950.925736113961;4982.87542811429;4997.50024997501;5016.673916195436;5029.899402011939;4947.084789313988;4980;4982.651214414992;5010.924836127461;5018.347614810088;4869.63477739171;4890.290907818347;4934.062528119646;4952.455229924705;4978.029284289565;5167.431582525919;5207.244949482304;5226.346706661668;5238.266642670029;5296.126139187029;5925.703714814285;5933.940660593382;5934.673592952386;5940.227770389865;5960.552958528085;5848.561357898175;5875.529957603381;5942.108683697436;5950.404959504058;5976.372480889531;5551.750171242304;5612.270404847425;5618.578606604521;5631.211630371751;5647.519960803336;6040;6043.879122417615;6082.787102451393;6104.786332478342;6108.450239478469;5685.346185188673;5784.161296611967;5818.127280907897;5890.175375447441;5902.527797776168;5887.2052272943465;5900.055991041499;5902.321233058167;5925.348211696796;5943.078822782476;5852.356240813507;5885.793997210077;5888.5289176865745;5892.616979896293;5892.646441213456;5739.971300143473;5794.739236734357;5802.535797136219;5889.676067816311;5898.203742494794;4486.304622783474;4498.910021799546;4503.594676479132;4525.841595544141;4545.545445455494;3971.3050216212046;3991.261616600938;3999.8000099994883;4027.1140349123148;4075.4090656855183;5395.379531353866;5514.09017512106;5524.696141712245;5569.248151499577;5617.494425501724;5880;5917.142014407887;5920.259967504062;5925.525957923356;5951.107333899863;5426.511613954763;5531;5554.6944918029085;5587.7485513152005;5606.187102870061;5009.824656137091;5082.949170508247;5083.059633967728;5086.287919691246;5138.2292656101135;6121.969390153021;6139.048447490646;6139.907901381483;6144.324124346229;6158.261008678987;5742.138679198154;5945.435183657545;5953.940460595339;5955.821325360246;5957.940420595912;5977.880442391215;6089.847753806191;6098.371716891094;6102.852830488404;6107.114468401968;5685.857853553694;5815.214945982408;5854.502367298657;5858.619189752652;5869.325027621708;5782.335031471434;5919.704014799329;5925.081612350093;5943.078822782476;5953.851153721192;5715.028445164416;5780.21967034445;5782.074868021096;5789.1895134680335;5822.155787410887;5825.446582574648;5831.154482599914;5840.357560668238;5841.50347220491;5844.94155058444;5455.563554915677;5489.890202195854;5587.3015873015875;5735.197072409949;5763.94236057634;5770.365259821332;5810.302763668386;5843.824685259449;5845.736941837543;5849.912251316148;5692;5720.141978703062;5738.053221218453;5739.770409183586;5740 19:14:04 INFO - 2015-11-19 19:14:04,313 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.4400155842598;591.2018774654217;593.8456001439624;601.5638661970071;649.2663290481755;29676.10971670848;39236.21527569447;39620;39855;39890.8005459973;40901.7954910225;41394.17211655765;41443;41473.79263103688;41500.169996600125;8608.827823443544;8808.867866982;8814.64741410346;8860.113988601153;8883.95558022209;8558.186972237627;8649.481031138152;8653.740387788377;8713.912860871405;8740.169683880022;8684.8697269541;8725.345599080063;8728.214460698537;8759.211670949613;8776.736697899041;8608.741737747878;8634.654613815472;8651.178138076904;8701.912980870173;8728.825423491558;8566.357523185787;8574.142585741438;8670.306375489945;8685.826283474295;8696.260817830429;37784.81107594472;38481;38488.80755596232;38620.42069368934;38670.61329386698;3223.1458663454205;3228.6448490666007;3300.488424294238;3378.4256676365076;3586.605473397924;28793.42413151725;28832.567511487134;29037.56443653347;29622.25944351387;30275.545866812015;3869.690424766012;3921;3949.447077409165;4021.8994525136814;4037.5147008990116;252364;253558.99999999817;253958;254273;254767;54419.72790136024;54421.45578544243;54622;54757.45242547603;54762.72618636961;67425.32574674289;68947.65526172437;68997.65501172462;69046;69165.65417172882;14695.485658001919;14807.963442559132;14836.70326593462;14891.776623350659;14998.175100369366;12178.695532611755;12406.62780116598;12417.192882462792;12496.437660305308;12508.49966001368;19762.604747904963;20106.69839952402;20197.798022019884;20273.594528109355;20308.492287692632;8132.227438393344;8267.255946964682;8286.378521610903;8295.502269863828;8309.210624990737;916.4547094478775;935.8830146231721;1020.1787561013456;1052.7894421115654;1131.2364154195884;27089.86455067712;27584.724152758616;27606.861965690445;27852.16443506698;31906.36187276288;987.2644879564771;1023.5752162852333;1033.1476531861244;1071.2287153249647;1123.7303047268597;14588.41646334156;14602.74369095803;14796.112233266038;14958.925205373904;15017.849821501864;376799;381268;381985;383547;383556;49759;50357.49642503601;50393.49606503962;50539.49460505348;50600;1326.290434617475;1328.9468421263234;1334.6996925691835;1336.1181620130667;1346.9326533673277;26732.331691707863;27574.172774816787;27835.860820696576;27986.300342491602;28003;42596;42979.785101074296;43064.35403469013;43211.35182972321;43224;288838;290081;290749;290983;292577;30608;42090.15819683528;42670.35994460023;43007.354889677306;43025.13949720925;47602.76198618985;48517.27224091712;48881.755591221816;49061.50938490712;49242.507574923795;35705.46441803427;36065.27869442544;36177.819110904275;37034.629653703116;37270.62729372671;35487.29025419425;36087.819560902026;36198.8190059048;36282.274354512236;36319.09202269858;38970.2205955885;39459.60540394559;39707.205855882145;39734.80132599434;40150.79924600358;30465;31066.68933310638;33448;33714.494282586274;33860.492092619126;25158.24525264245;25689.378229323687;25802;25806;26045.348866278495 19:14:04 INFO - 2015-11-19 19:14:04,314 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.53860903607233;355.87722235828636;358.1366971066322;358.1583279293662;362.3351150638578;16313.836861631395;16685.41601043962;17351.305947762106;17479.388221412253;18154;10885.945570272137;11859.644210673672;15582.844171558281;15812.683746325096;15850.84149158508;4588.655850811186;4981.476944920785;4984.252362145689;4987.950120498803;4999.500049994989;4897.1674815281485;4961.429435614915;4963.156263435225;4971.825986090487;4988.152014157584;4980.750962451881;5025.1708468102715;5040.697558146505;5095.847124586268;5327.893442131155;4983.975080124613;5069.036882992256;5080.847574572768;5087.5421212090905;5099.770510327045;4857.73282469464;5298.92051619226;5327.893442131174;5343;5352.57179425645;12365.752684946341;12564.120511564193;14202.431902723878;20847.478813029644;20868.373948781562;2049.8975051247526;2095.3609149209483;2109.514811593342;2154.2567814104264;2252.831037672181;9411.105944935289;9686.418814871131;10222.0289072538;10327.431991240479;13193;1778.7776527934009;1799.1364145210373;1836.9816301837077;1844.8708590398678;1896.2225487550038;58839.70580147072;60383.69808150975;61184;61195;61797;9849.162821160282;10022.849657255147;10087.092161705335;10101.646442374482;10269.897301026895;13282.003849711311;13338.466461341632;13390.263535505446;13413.0610857241;13467.12463689857;7417.7774666759005;7496.400287976949;7563.810904727426;7746.961265193638;7869.1737367576725;7128.6435678215885;7148.785536433916;7227.5302105364035;7252.492325537267;7266.564006159648;4343;4356.542563030899;4393.055493069006;4393.231184542756;4461.933071003938;1760.5651394113756;1791.167107295114;1799.388208009257;1811.4022372617005;1815.0743121008381;380.52244433236666;387.179180138109;390.87882756345056;397.4614397491415;941.6327632223438;8820.779480513038;9314.34799564024;9632.855507167398;9649.372790768577;10117.836448808333;368.18814513996574;369.1435868784448;385.1545856844256;416.7707760731586;426.0584109118882;5450.236966824647;5483.616146869681;5554.1391084381985;5569.303837020372;5617.32592088952;502702;505516;512843;531703;536604;70124;74295;76037.23962760413;77529.22470775332;78392.60803695946;1144.605111236622;1155.0759392486145;1167.7255844876618;1169.5263418315596;1174.6358628825092;14750.483733069292;14938.551843444715;14996.475123371067;15082.54752357431;15417.383304668136;31458.52812207773;31961.36077278488;32839.50740738843;33005.66994330122;36490.452643210905;44872.55127448814;45741.771291144665;48242.75878620584;52131;53277;14289.71420571562;15154.696906062038;15222.391104355702;15249.313780879666;15501.922490387477;18062.90968545149;18153.45539633813;18668.626627467645;18802.811971880106;18854.151563179963;9094.499802510925;9157.725268241964;9374.203192728695;9476.668316608886;9535.23718102564;8775.692850750193;8946.463212207289;9042.412243204171;9120.680776172801;9192.402493837879;9356.766080848034;9532.285078618992;9544.33189676716;9547.665831695856;9588.76028099303;14311.499097531536;14786.778198326818;15022;15074;15329.233538323262;9064.274858011475;9239.72280831576;9423.340366174576;15720.764188536952;15903.125328107066 19:14:04 INFO - 2015-11-19 19:14:04,317 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1477.7635578307459;1556.7275726747816;1560.9921950390246;1634.8773841961852;1705.1900347335018;7052.823679408018;7326.120865496135;7370.5577665340115;7373.594452305121;7581.128170260422;7429.257074292568;7455.701771929116;7512.060992375953;7527.059117610299;7535.924640753591;2196.1105752170356;2214.6567282071305;2217.2128894242555;2219.0901730290584;2226.3432287475152;2229.944251393712;2270.9545809083806;2272.068451934707;2284.8286378521593;2293.2776175504746;2127.936161915145;2161.243564752332;2172.945676358088;2196;2221.866687998717;2186.147402513021;2209.171560664751;2220.4226901005854;2231.8995645196005;2242.3273018094505;2250.786175313359;2263.343630347214;2271.193726227182;2272.7954484096513;2274.5678321118935;7281.5631062136445;7296.270372962715;7355.37479314259;7369.078865141857;7403.4447416443445;4451.065276291983;4509.143262780061;4537.773111344452;4545.568171023748;4556.817727290904;2970.4801659709465;3060.8928687496054;3072.9539056914164;3073.2624170199215;3098.4732595458827;1023.5752162852407;1032.6747074671455;1049.7060822969581;1068.8717353917502;1072.587053984214;10027.448490332956;10079.395236285847;10166.745831354201;10168.79662406755;10176;3929.76421414716;3935.58676338986;3956.8615098471414;4013.4381186633896;4081.5102187737066;8315.168483151758;8343.541105239148;8364.912561366984;8432.620532076071;8436.072032076467;4514.61625761814;4534.9319760203625;4538.2738761797955;4545.250033744395;4551.499335073139;4182.456280683553;4195.223883581547;4205.222033923673;4210.810513526899;4236.025714085716;3260.5924259467565;3292.654271301527;3303.8678452862096;3328.5007248912857;3329.93340133196;1027.7584767579613;1045.10643399892;1046.3512622174148;1061.4586560853866;1061.4851796878509;1017.8218811708069;1032.5353590884133;1085.5277954089995;1126.898579127866;1231.0643910627807;6920.377166055079;6924.23833378328;6940.618265995418;6963.895541566881;6976.895346569806;1173.1318824070297;1176.147293212414;1178.1635039122318;1185.5613423033533;1222.2238878312335;5616.157576363496;5644.096944488862;5646.85882852932;5653.378128405872;5654.802081927195;8651.567421628893;8747.737567872973;8758.47449153053;8779.648814047367;8849.60176792046;7656.119546252252;7671.6164191790185;7673.309402153833;7682.078150621961;7702.229777022253;6950.235474097845;6967.756128535477;6980.7905762827195;7033.261507541634;7038.92961070393;6922.550034247758;6936.237013928565;6941.757038503628;7005.334493223136;7012.544184627983;7794.259545343183;7936.761897143095;7939.722109726363;7951.562664053533;7982.401319901147;8026.518408895485;8092.433529652868;8191.344692424473;8194;8223.95888020556;6933.168019837652;6995.720171193096;7192;7219.45854060937;7219.747308844166;7075.752348667772;7186.89219661695;7188.065551478275;7196.460265480215;7197;6755.662216889037;6840.863182736218;6844.794656160323;6979.581225126509;7022.964885175541;6624.966875165594;6662.467002639681;6678.933210667831;6799.728010879509;6825.624590647363;6803.897941530782;6956.582605043714;6988.755393561201;7011.824704382431;7012.544184627983;6263.6241825490615;6366.395192456709;6376.904346434714;6382.648954307558;6385.904211436925;6282.811515654537;6290.748370065329;6343.207099112611;6345.904811427925;6368.808935731936 19:14:04 INFO - 2015-11-19 19:14:04,318 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.7459968524395;330.53229680002795;331.8473502188993;333.76803121830335;336.8198014062476;6343.397377249165;6348.111264422984;6350.523710721697;6368.681565921703;6496.642684652342;6272.153259309992;6300.5589608727405;6314.810555683325;6315.589486683374;6323.74705011799;4732.1482133216;4737.881552961169;4756.66703330767;4762.880927976794;4764.999350136475;4747.928781068269;4748.857534273978;4755.9286610700865;4770.212914869043;4772.642051846108;4640.3967484227005;4800.159972004903;4801.831935882245;4803.591694705954;4809.711417314955;4772.832950846721;4783.115123702109;4787.234042553209;4798.592119669832;4805.687630304019;4158.6465150462245;4159.604837540429;4161.979190104061;4176;4179.226843034048;5973.8805223895715;5993.940060599425;5994.310654274771;5995.730192141321;6009.248843894513;5387.218853266294;5460.6177567570285;5471.890562188734;5472.863178420572;5481.424450432727;6701.765438209688;6710.429613482811;6732.461403087741;6736.2590115087305;6739.326067393271;4454.443194600675;4458.464984201884;4464.241079016575;4467.977660111711;4477.552244775529;6754.898676519856;6888.758893438756;6938.930610693929;6950.5482143661;6975.128108986377;4645.837395691135;4651.09303685778;4651.674382793172;4653.883652908705;4656.813727450932;4683.812647494062;4686.742229177428;4692.835750748707;4699.765011749399;4721.362616046789;5496.615236933456;5502.422245664227;5504.311961004874;5510.91733623996;5527.281453411031;6616.536842420985;6714.060031595581;6724.596524208465;6738.292479289604;6795.592264464148;1628.9185540722917;1671.7158083125655;1688.4681325382464;1689.5944973206588;1694.2883988724766;1122.0967121467297;1143.2511704833348;1153.313778301909;1164.8019836627793;1175.6473058082713;6360.268569114519;6421.614703117734;6422.261439934374;6432.51756118293;6435.806925792233;6813.591184528944;6817.625030623264;6843.965780171166;6846.178458585002;6862.3823855852215;6308.589941653778;6325.65208913505;6366.936330636634;6368.235811702625;6397.072424498421;3791.5071040764524;3796.032011837019;3812.6568608825337;3815.7901315427916;3816.3130636485143;7200.171980222237;7224.891626625605;7247.16657584374;7256.6734496947765;7266.346028857428;7028.683709233097;7174.856502869913;7175.103112110986;7186.461015423864;7198;7216.567005979553;7217.422606191387;7262.745803896838;7280.0535930328715;7295.088113985752;6976.127984002;7010.298970102949;7019.789406317818;7031.08595882532;7035.648217589202;6739.46084313244;6963.373296403348;6970;6970.442364610921;6987.475939304471;7295.963520182578;7300.744473943387;7301.488895777245;7302.123745150616;7310.96344518274;4683.34433179362;4722.890120821673;4724.362211101457;4728.31439441286;4731.739754313546;6748.089007983859;6784.626845523544;6920.5847649141215;6956.991236270611;6963.234044255027;6734.528582999143;6752.08846805675;6759.662016899234;6832.214295356098;6849.554778939353;6725.831854203489;6743.865122697617;6754.696038678173;6780.423439093311;6801.421879140328;6510.609363438209;6653.667316634052;6655.168103987002;6657.06801047844;6668.866622667422;6760.695768690519;6797.966010169917;6811.795646130624;6812.829679258059;6824.044633751378;6630.403263706096;6640.734370625121;6664.8000559983275;6673.566218195801;6676.732930682719 19:14:04 INFO - 2015-11-19 19:14:04,320 DEBUG : BROWSER_OUTPUT: |5;yui.html;742.2429122295259;791.4064451661254;808.5754978636215;840.2899549880353;842.9873551896719;14135.78796318056;14512.927435362835;14563.85436145641;14597.635059123513;14616.26918654067;13493.257870817126;13562.389692463837;13573.932130339335;13614;13617.182969021866;803.1887793328751;820.4994953078617;830.7341650671788;832.92087251711;835.2941764209233;819.491915012693;829.179112678447;831.4138532334689;831.9958400208021;832.1512057701141;849.6771226933787;858.3176374782063;858.356232825381;862.779991102268;863.2619110660389;845.5983407881268;845.8139209373959;850.8638617821181;851.9574021298911;853.7097386888456;627.1126356206008;627.9560430769848;630.5995692735146;631.6147150238351;632.7911789109629;13362.131461454974;13440.731185376335;13480.5281815136;13541.255230962293;13564.186148831002;12147.878521214763;12166.391680415943;12536.686582835411;12542.828384000133;12567.622971310784;10541;10832.295900766425;10884.782304353948;11361.43192840363;11861.347625880573;3646.6535679110443;3720.330340538702;3721.7208709346905;3734.1598140418187;3854.4411060396365;45601.771991140165;46168.3074753879;46274.30588541175;46300.07399852018;46435.76782116102;10046;10187.388756674623;10657.467126643636;10846.945765271123;10870.076043536388;19003.80996190048;19085.427437176906;19178.80821191798;19192.904035480013;19224;7475.168583697029;7486.588237646873;7606.201348858401;7702.152763196044;7757.1079325878245;4098.221337945781;4304.82780688769;4380.364847097153;4420.160169567772;4450.910981780346;3027.8031927924612;3057.29682173097;3062.096681478969;3062.372213696187;3065.3103051813164;586.61576667283;590.5452801342942;598.2730981856978;598.964062156272;599.0325624117106;631.8704665543553;662.8144119646506;673.8618583190532;686.615495322621;691.8339598496325;7933.167017463199;8065.233802788725;8090.352771778244;8119.634616442274;8199.7950051248;534.3374215972244;655.0828839624563;659.0378048049805;669.2588430672564;676.1818199977984;3674.3202507536193;3680;3709.4806727058235;3753.249350129985;3754.662080412776;51898;56156.438435615935;59247.40752592505;59264;59319;47058.5294147061;47179.76410117927;47305;47816;48368;45963;46616.533834661896;47150.76424617855;47199.292010619865;47396.99999999931;8075.878861817195;8206.466579672302;8293.626786794488;8419;8439.493630382196;34152.31695366029;34270.657293426746;34667.826660866536;34861;34942.12644683802;41155.58844411517;41307;45865.54134458746;45900.31149532693;46293.768531157126;10438.802297373315;10734;10858.45707714627;10969.83545246806;11121.16591255643;11082;11431.142664300045;11516;11635.47640356169;11826.940865295619;10568.959488485816;10693.786124277316;10730.302530335503;10734.83897741519;10978.945105274743;10837.349759014485;10853.34879907208;11068.501917413896;11133.832992504957;11468.770624587294;10096.242781791248;10152.644657436955;10418.218633602359;10497.52761125736;11159.10727141843;9289.72130836076;9400;9404;9645.228381729305;9717.951410242904;8687.522186279815;8821.955890220765;9138.497382644018;9212;9234.538273086453 19:14:04 INFO - 2015-11-19 19:14:04,320 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:14:04 INFO - 2015-11-19 19:14:04,320 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:14:04 INFO - 2015-11-19 19:14:04,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,288 19:14:04 INFO - 2015-11-19 19:14:04,321 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:14:04 INFO - 2015-11-19 19:14:04,322 DEBUG : BROWSER_OUTPUT: __startTimestamp1447989244310__endTimestamp 19:14:04 INFO - 2015-11-19 19:14:04,322 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5469.36 Median:5720.14 stddev:624.64 (10.9%) stddev-sans-first:600.43 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: Values: 3190.5 3249.3 3275.9 3282.5 3315.5 5278.3 5387.2 5439.7 5441.8 5446.7 5404.0 5454.8 5461.2 5493.4 5505.0 4661.2 4900.5 5080.5 5100.4 5100.5 4890.7 5063.3 5082.0 5143.7 5170.9 4950.9 4982.9 4997.5 5016.7 5029.9 4947.1 4980.0 4982.7 5010.9 5018.3 4869.6 4890.3 4934.1 4952.5 4978.0 5167.4 5207.2 5226.3 5238.3 5296.1 5925.7 5933.9 5934.7 5940.2 5960.6 5848.6 5875.5 5942.1 5950.4 5976.4 5551.8 5612.3 5618.6 5631.2 5647.5 6040.0 6043.9 6082.8 6104.8 6108.5 5685.3 5784.2 5818.1 5890.2 5902.5 5887.2 5900.1 5902.3 5925.3 5943.1 5852.4 5885.8 5888.5 5892.6 5892.6 5740.0 5794.7 5802.5 5889.7 5898.2 4486.3 4498.9 4503.6 4525.8 4545.5 3971.3 3991.3 3999.8 4027.1 4075.4 5395.4 5514.1 5524.7 5569.2 5617.5 5880.0 5917.1 5920.3 5925.5 5951.1 5426.5 5531.0 5554.7 5587.7 5606.2 5009.8 5082.9 5083.1 5086.3 5138.2 6122.0 6139.0 6139.9 6144.3 6158.3 5742.1 5945.4 5953.9 5955.8 5957.9 5977.9 6089.8 6098.4 6102.9 6107.1 5685.9 5815.2 5854.5 5858.6 5869.3 5782.3 5919.7 5925.1 5943.1 5953.9 5715.0 5780.2 5782.1 5789.2 5822.2 5825.4 5831.2 5840.4 5841.5 5844.9 5455.6 5489.9 5587.3 5735.2 5763.9 5770.4 5810.3 5843.8 5845.7 5849.9 5692.0 5720.1 5738.1 5739.8 5740.0 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,323 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48049.33 Median:38484.90 stddev:82185.95 (213.6%) stddev-sans-first:82339.13 19:14:04 INFO - 2015-11-19 19:14:04,324 DEBUG : BROWSER_OUTPUT: Values: 554.4 591.2 593.8 601.6 649.3 29676.1 39236.2 39620.0 39855.0 39890.8 40901.8 41394.2 41443.0 41473.8 41500.2 8608.8 8808.9 8814.6 8860.1 8884.0 8558.2 8649.5 8653.7 8713.9 8740.2 8684.9 8725.3 8728.2 8759.2 8776.7 8608.7 8634.7 8651.2 8701.9 8728.8 8566.4 8574.1 8670.3 8685.8 8696.3 37784.8 38481.0 38488.8 38620.4 38670.6 3223.1 3228.6 3300.5 3378.4 3586.6 28793.4 28832.6 29037.6 29622.3 30275.5 3869.7 3921.0 3949.4 4021.9 4037.5 252364.0 253559.0 253958.0 254273.0 254767.0 54419.7 54421.5 54622.0 54757.5 54762.7 67425.3 68947.7 68997.7 69046.0 69165.7 14695.5 14808.0 14836.7 14891.8 14998.2 12178.7 12406.6 12417.2 12496.4 12508.5 19762.6 20106.7 20197.8 20273.6 20308.5 8132.2 8267.3 8286.4 8295.5 8309.2 916.5 935.9 1020.2 1052.8 1131.2 27089.9 27584.7 27606.9 27852.2 31906.4 987.3 1023.6 1033.1 1071.2 1123.7 14588.4 14602.7 14796.1 14958.9 15017.8 376799.0 381268.0 381985.0 383547.0 383556.0 49759.0 50357.5 50393.5 50539.5 50600.0 1326.3 1328.9 1334.7 1336.1 1346.9 26732.3 27574.2 27835.9 27986.3 28003.0 42596.0 42979.8 43064.4 43211.4 43224.0 288838.0 290081.0 290749.0 290983.0 292577.0 30608.0 42090.2 42670.4 43007.4 43025.1 47602.8 48517.3 48881.8 49061.5 49242.5 35705.5 36065.3 36177.8 37034.6 37270.6 35487.3 36087.8 36198.8 36282.3 36319.1 38970.2 39459.6 39707.2 39734.8 40150.8 30465.0 31066.7 33448.0 33714.5 33860.5 25158.2 25689.4 25802.0 25806.0 26045.3 19:14:04 INFO - 2015-11-19 19:14:04,324 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,324 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27448.79 Median:4374.80 stddev:84744.91 (1937.1%) stddev-sans-first:84958.21 19:14:04 INFO - 2015-11-19 19:14:04,324 DEBUG : BROWSER_OUTPUT: Values: 349.5 355.9 358.1 358.2 362.3 16313.8 16685.4 17351.3 17479.4 18154.0 10885.9 11859.6 15582.8 15812.7 15850.8 4588.7 4981.5 4984.3 4988.0 4999.5 4897.2 4961.4 4963.2 4971.8 4988.2 4980.8 5025.2 5040.7 5095.8 5327.9 4984.0 5069.0 5080.8 5087.5 5099.8 4857.7 5298.9 5327.9 5343.0 5352.6 12365.8 12564.1 14202.4 20847.5 20868.4 2049.9 2095.4 2109.5 2154.3 2252.8 9411.1 9686.4 10222.0 10327.4 13193.0 1778.8 1799.1 1837.0 1844.9 1896.2 58839.7 60383.7 61184.0 61195.0 61797.0 9849.2 10022.8 10087.1 10101.6 10269.9 13282.0 13338.5 13390.3 13413.1 13467.1 7417.8 7496.4 7563.8 7747.0 7869.2 7128.6 7148.8 7227.5 7252.5 7266.6 4343.0 4356.5 4393.1 4393.2 4461.9 1760.6 1791.2 1799.4 1811.4 1815.1 380.5 387.2 390.9 397.5 941.6 8820.8 9314.3 9632.9 9649.4 10117.8 368.2 369.1 385.2 416.8 426.1 5450.2 5483.6 5554.1 5569.3 5617.3 502702.0 505516.0 512843.0 531703.0 536604.0 70124.0 74295.0 76037.2 77529.2 78392.6 1144.6 1155.1 1167.7 1169.5 1174.6 14750.5 14938.6 14996.5 15082.5 15417.4 31458.5 31961.4 32839.5 33005.7 36490.5 44872.6 45741.8 48242.8 52131.0 53277.0 14289.7 15154.7 15222.4 15249.3 15501.9 18062.9 18153.5 18668.6 18802.8 18854.2 9094.5 9157.7 9374.2 9476.7 9535.2 8775.7 8946.5 9042.4 9120.7 9192.4 9356.8 9532.3 9544.3 9547.7 9588.8 14311.5 14786.8 15022.0 15074.0 15329.2 9064.3 9239.7 9423.3 15720.8 15903.1 19:14:04 INFO - 2015-11-19 19:14:04,324 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,325 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5221.34 Median:6273.22 stddev:2631.09 (41.9%) stddev-sans-first:2623.43 19:14:04 INFO - 2015-11-19 19:14:04,325 DEBUG : BROWSER_OUTPUT: Values: 1477.8 1556.7 1561.0 1634.9 1705.2 7052.8 7326.1 7370.6 7373.6 7581.1 7429.3 7455.7 7512.1 7527.1 7535.9 2196.1 2214.7 2217.2 2219.1 2226.3 2229.9 2271.0 2272.1 2284.8 2293.3 2127.9 2161.2 2172.9 2196.0 2221.9 2186.1 2209.2 2220.4 2231.9 2242.3 2250.8 2263.3 2271.2 2272.8 2274.6 7281.6 7296.3 7355.4 7369.1 7403.4 4451.1 4509.1 4537.8 4545.6 4556.8 2970.5 3060.9 3073.0 3073.3 3098.5 1023.6 1032.7 1049.7 1068.9 1072.6 10027.4 10079.4 10166.7 10168.8 10176.0 3929.8 3935.6 3956.9 4013.4 4081.5 8315.2 8343.5 8364.9 8432.6 8436.1 4514.6 4534.9 4538.3 4545.3 4551.5 4182.5 4195.2 4205.2 4210.8 4236.0 3260.6 3292.7 3303.9 3328.5 3329.9 1027.8 1045.1 1046.4 1061.5 1061.5 1017.8 1032.5 1085.5 1126.9 1231.1 6920.4 6924.2 6940.6 6963.9 6976.9 1173.1 1176.1 1178.2 1185.6 1222.2 5616.2 5644.1 5646.9 5653.4 5654.8 8651.6 8747.7 8758.5 8779.6 8849.6 7656.1 7671.6 7673.3 7682.1 7702.2 6950.2 6967.8 6980.8 7033.3 7038.9 6922.6 6936.2 6941.8 7005.3 7012.5 7794.3 7936.8 7939.7 7951.6 7982.4 8026.5 8092.4 8191.3 8194.0 8224.0 6933.2 6995.7 7192.0 7219.5 7219.7 7075.8 7186.9 7188.1 7196.5 7197.0 6755.7 6840.9 6844.8 6979.6 7023.0 6625.0 6662.5 6678.9 6799.7 6825.6 6803.9 6956.6 6988.8 7011.8 7012.5 6263.6 6366.4 6376.9 6382.6 6385.9 6282.8 6290.7 6343.2 6345.9 6368.8 19:14:04 INFO - 2015-11-19 19:14:04,326 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,326 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5603.45 Median:6363.60 stddev:1717.26 (27.0%) stddev-sans-first:1675.80 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: Values: 327.7 330.5 331.8 333.8 336.8 6343.4 6348.1 6350.5 6368.7 6496.6 6272.2 6300.6 6314.8 6315.6 6323.7 4732.1 4737.9 4756.7 4762.9 4765.0 4747.9 4748.9 4755.9 4770.2 4772.6 4640.4 4800.2 4801.8 4803.6 4809.7 4772.8 4783.1 4787.2 4798.6 4805.7 4158.6 4159.6 4162.0 4176.0 4179.2 5973.9 5993.9 5994.3 5995.7 6009.2 5387.2 5460.6 5471.9 5472.9 5481.4 6701.8 6710.4 6732.5 6736.3 6739.3 4454.4 4458.5 4464.2 4468.0 4477.6 6754.9 6888.8 6938.9 6950.5 6975.1 4645.8 4651.1 4651.7 4653.9 4656.8 4683.8 4686.7 4692.8 4699.8 4721.4 5496.6 5502.4 5504.3 5510.9 5527.3 6616.5 6714.1 6724.6 6738.3 6795.6 1628.9 1671.7 1688.5 1689.6 1694.3 1122.1 1143.3 1153.3 1164.8 1175.6 6360.3 6421.6 6422.3 6432.5 6435.8 6813.6 6817.6 6844.0 6846.2 6862.4 6308.6 6325.7 6366.9 6368.2 6397.1 3791.5 3796.0 3812.7 3815.8 3816.3 7200.2 7224.9 7247.2 7256.7 7266.3 7028.7 7174.9 7175.1 7186.5 7198.0 7216.6 7217.4 7262.7 7280.1 7295.1 6976.1 7010.3 7019.8 7031.1 7035.6 6739.5 6963.4 6970.0 6970.4 6987.5 7296.0 7300.7 7301.5 7302.1 7311.0 4683.3 4722.9 4724.4 4728.3 4731.7 6748.1 6784.6 6920.6 6957.0 6963.2 6734.5 6752.1 6759.7 6832.2 6849.6 6725.8 6743.9 6754.7 6780.4 6801.4 6510.6 6653.7 6655.2 6657.1 6668.9 6760.7 6798.0 6811.8 6812.8 6824.0 6630.4 6640.7 6664.8 6673.6 6676.7 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13603.61 Median:46065.65 stddev:15590.06 (33.8%) stddev-sans-first:15603.87 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: Values: 742.2 791.4 808.6 840.3 843.0 14135.8 14512.9 14563.9 14597.6 14616.3 13493.3 13562.4 13573.9 13614.0 13617.2 803.2 820.5 830.7 832.9 835.3 819.5 829.2 831.4 832.0 832.2 849.7 858.3 858.4 862.8 863.3 845.6 845.8 850.9 852.0 853.7 627.1 628.0 630.6 631.6 632.8 13362.1 13440.7 13480.5 13541.3 13564.2 12147.9 12166.4 12536.7 12542.8 12567.6 10541.0 10832.3 10884.8 11361.4 11861.3 3646.7 3720.3 3721.7 3734.2 3854.4 45601.8 46168.3 46274.3 46300.1 46435.8 10046.0 10187.4 10657.5 10846.9 10870.1 19003.8 19085.4 19178.8 19192.9 19224.0 7475.2 7486.6 7606.2 7702.2 7757.1 4098.2 4304.8 4380.4 4420.2 4450.9 3027.8 3057.3 3062.1 3062.4 3065.3 586.6 590.5 598.3 599.0 599.0 631.9 662.8 673.9 686.6 691.8 7933.2 8065.2 8090.4 8119.6 8199.8 534.3 655.1 659.0 669.3 676.2 3674.3 3680.0 3709.5 3753.2 3754.7 51898.0 56156.4 59247.4 59264.0 59319.0 47058.5 47179.8 47305.0 47816.0 48368.0 45963.0 46616.5 47150.8 47199.3 47397.0 8075.9 8206.5 8293.6 8419.0 8439.5 34152.3 34270.7 34667.8 34861.0 34942.1 41155.6 41307.0 45865.5 45900.3 46293.8 10438.8 10734.0 10858.5 10969.8 11121.2 11082.0 11431.1 11516.0 11635.5 11826.9 10569.0 10693.8 10730.3 10734.8 10978.9 10837.3 10853.3 11068.5 11133.8 11468.8 10096.2 10152.6 10418.2 10497.5 11159.1 9289.7 9400.0 9404.0 9645.2 9718.0 8687.5 8822.0 9138.5 9212.0 9234.5 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:14:04 INFO - 2015-11-19 19:14:04,327 DEBUG : BROWSER_OUTPUT: 19:14:05 INFO - 2015-11-19 19:14:05,042 INFO : Browser exited with error code: 0 19:14:05 INFO - 2015-11-19 19:14:05,060 INFO : Completed test dromaeo_css (00:18:31) 19:14:05 INFO - 2015-11-19 19:14:05,060 INFO : Starting test kraken 19:14:05 INFO - 2015-11-19 19:14:05,060 DEBUG : operating with platform_type : linux_ 19:14:05 INFO - 2015-11-19 19:14:05,061 INFO : Initialising browser for kraken test... 19:14:05 INFO - 2015-11-19 19:14:05,066 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgd1Giq/profile http://localhost:51401/getInfo.html 19:14:09 INFO - 2015-11-19 19:14:09,510 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:14:09 INFO - 2015-11-19 19:14:09,510 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:14:09 INFO - 2015-11-19 19:14:09,510 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:14:09 INFO - 2015-11-19 19:14:09,511 DEBUG : BROWSER_OUTPUT: __metrics 19:14:10 INFO - 2015-11-19 19:14:10,501 INFO : Browser initialized. 19:14:10 INFO - 2015-11-19 19:14:10,502 INFO : Running cycle 1/1 for kraken test... 19:14:10 INFO - 2015-11-19 19:14:10,502 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgd1Giq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:14:22 INFO - 2015-11-19 19:14:22,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 141148160 19:14:22 INFO - 2015-11-19 19:14:22,234 DEBUG : BROWSER_OUTPUT: 19:14:24 INFO - 2015-11-19 19:14:24,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51401/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:25 INFO - 2015-11-19 19:14:25,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 141025280 19:14:25 INFO - 2015-11-19 19:14:25,351 DEBUG : BROWSER_OUTPUT: 19:14:28 INFO - 2015-11-19 19:14:28,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51401/tests/kraken/driver.html?testName=audio-dft) 19:14:28 INFO - 2015-11-19 19:14:28,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 141438976 19:14:28 INFO - 2015-11-19 19:14:28,609 DEBUG : BROWSER_OUTPUT: 19:14:31 INFO - 2015-11-19 19:14:31,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51401/tests/kraken/driver.html?testName=audio-fft) 19:14:32 INFO - 2015-11-19 19:14:32,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 137023488 19:14:32 INFO - 2015-11-19 19:14:32,038 DEBUG : BROWSER_OUTPUT: 19:14:34 INFO - 2015-11-19 19:14:34,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51401/tests/kraken/driver.html?testName=audio-oscillator) 19:14:34 INFO - 2015-11-19 19:14:34,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 137367552 19:14:34 INFO - 2015-11-19 19:14:34,574 DEBUG : BROWSER_OUTPUT: 19:14:36 INFO - 2015-11-19 19:14:36,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:37 INFO - 2015-11-19 19:14:37,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 135782400 19:14:37 INFO - 2015-11-19 19:14:37,352 DEBUG : BROWSER_OUTPUT: 19:14:40 INFO - 2015-11-19 19:14:40,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51401/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:40 INFO - 2015-11-19 19:14:40,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 137650176 19:14:40 INFO - 2015-11-19 19:14:40,945 DEBUG : BROWSER_OUTPUT: 19:14:44 INFO - 2015-11-19 19:14:44,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51401/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:44 INFO - 2015-11-19 19:14:44,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 19:14:44 INFO - 2015-11-19 19:14:44,926 DEBUG : BROWSER_OUTPUT: 19:14:47 INFO - 2015-11-19 19:14:47,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51401/tests/kraken/driver.html?testName=json-parse-financial) 19:14:48 INFO - 2015-11-19 19:14:48,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 138960896 19:14:48 INFO - 2015-11-19 19:14:48,359 DEBUG : BROWSER_OUTPUT: 19:14:49 INFO - 2015-11-19 19:14:49,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:50 INFO - 2015-11-19 19:14:50,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 19:14:50 INFO - 2015-11-19 19:14:50,568 DEBUG : BROWSER_OUTPUT: 19:14:52 INFO - 2015-11-19 19:14:52,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:53 INFO - 2015-11-19 19:14:53,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 139493376 19:14:53 INFO - 2015-11-19 19:14:53,018 DEBUG : BROWSER_OUTPUT: 19:14:55 INFO - 2015-11-19 19:14:55,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:55 INFO - 2015-11-19 19:14:55,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 139845632 19:14:55 INFO - 2015-11-19 19:14:55,677 DEBUG : BROWSER_OUTPUT: 19:14:58 INFO - 2015-11-19 19:14:58,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:58 INFO - 2015-11-19 19:14:58,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 19:14:58 INFO - 2015-11-19 19:14:58,735 DEBUG : BROWSER_OUTPUT: 19:15:01 INFO - 2015-11-19 19:15:01,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:01 INFO - 2015-11-19 19:15:01,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 19:15:01 INFO - 2015-11-19 19:15:01,884 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51401/tests/kraken/driver.html?testName=ai-astar) 19:15:03 INFO - 2015-11-19 19:15:03,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 138895360 19:15:03 INFO - 2015-11-19 19:15:03,823 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,827 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:03 INFO - 2015-11-19 19:15:03,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:03 INFO - 2015-11-19 19:15:03,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:03 INFO - 2015-11-19 19:15:03,827 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:03 INFO - 2015-11-19 19:15:03,828 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;103;112;111;113;126;110;112;111;109 19:15:03 INFO - 2015-11-19 19:15:03,828 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;154;165;133;157;160;129;167;127 19:15:03 INFO - 2015-11-19 19:15:03,828 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;164;165;160;163;165;171;162 19:15:03 INFO - 2015-11-19 19:15:03,828 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;72;73;73;138;75;73;73;71 19:15:03 INFO - 2015-11-19 19:15:03,828 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;147;92;93;92;148;90;91;131 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;111;110 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;146;147;147;147;147;146;146;147 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;96;98;97;96;96;96 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;65;67;69;66;67;66;68;63;63 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;70;70;69;70 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;93;85;84;85;85;94;86 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;115;121;128;132;119;115;134;115 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;152;150;158;154;144;142;150;154;142 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;70;69;70;69;68;68;68 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:03 INFO - 2015-11-19 19:15:03,829 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:15:03 INFO - 2015-11-19 19:15:03,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,698 19:15:03 INFO - 2015-11-19 19:15:03,830 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:15:03 INFO - 2015-11-19 19:15:03,830 DEBUG : BROWSER_OUTPUT: __startTimestamp1447989303825__endTimestamp 19:15:03 INFO - 2015-11-19 19:15:03,830 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,833 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:03 INFO - 2015-11-19 19:15:03,833 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:15:03 INFO - 2015-11-19 19:15:03,833 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:5.74 (5.1%) stddev-sans-first:6.05 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: Values: 114.0 103.0 112.0 111.0 113.0 126.0 110.0 112.0 111.0 109.0 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.60 Median:155.50 stddev:16.84 (10.8%) stddev-sans-first:17.79 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 154.0 165.0 133.0 157.0 160.0 129.0 167.0 127.0 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.94 (1.8%) stddev-sans-first:3.10 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 164.0 165.0 160.0 163.0 165.0 171.0 162.0 19:15:03 INFO - 2015-11-19 19:15:03,834 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:20.58 (28.2%) stddev-sans-first:21.70 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 73.0 73.0 138.0 75.0 73.0 73.0 71.0 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:91.50 stddev:24.86 (27.2%) stddev-sans-first:25.63 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 147.0 92.0 93.0 92.0 148.0 90.0 91.0 131.0 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 19:15:03 INFO - 2015-11-19 19:15:03,835 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 96.0 98.0 97.0 96.0 96.0 96.0 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.50 stddev:1.97 (3.0%) stddev-sans-first:2.06 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 69.0 66.0 67.0 66.0 68.0 63.0 63.0 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 70.0 70.0 69.0 70.0 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:3.69 (4.3%) stddev-sans-first:3.79 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 93.0 85.0 84.0 85.0 85.0 94.0 86.0 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:123.00 stddev:7.06 (5.7%) stddev-sans-first:7.43 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 115.0 121.0 128.0 132.0 119.0 115.0 134.0 115.0 19:15:03 INFO - 2015-11-19 19:15:03,836 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:151.00 stddev:6.19 (4.1%) stddev-sans-first:5.73 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: Values: 140.0 152.0 150.0 158.0 154.0 144.0 142.0 150.0 154.0 142.0 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 70.0 69.0 70.0 69.0 68.0 68.0 68.0 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:03 INFO - 2015-11-19 19:15:03,837 DEBUG : BROWSER_OUTPUT: 19:15:04 INFO - 2015-11-19 19:15:04,849 INFO : Browser exited with error code: 0 19:15:04 INFO - 2015-11-19 19:15:04,901 INFO : Completed test kraken (00:00:59) 19:15:04 INFO - 2015-11-19 19:15:04,901 INFO : Starting test v8_7 19:15:04 INFO - 2015-11-19 19:15:04,901 DEBUG : operating with platform_type : linux_ 19:15:04 INFO - 2015-11-19 19:15:04,901 INFO : Initialising browser for v8_7 test... 19:15:04 INFO - 2015-11-19 19:15:04,907 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYEs7nN/profile http://localhost:51401/getInfo.html 19:15:09 INFO - 2015-11-19 19:15:09,325 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:15:09 INFO - 2015-11-19 19:15:09,325 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:15:09 INFO - 2015-11-19 19:15:09,325 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:15:09 INFO - 2015-11-19 19:15:09,325 DEBUG : BROWSER_OUTPUT: __metrics 19:15:10 INFO - 2015-11-19 19:15:10,425 INFO : Browser initialized. 19:15:10 INFO - 2015-11-19 19:15:10,426 INFO : Running cycle 1/1 for v8_7 test... 19:15:10 INFO - 2015-11-19 19:15:10,426 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYEs7nN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:15:22 INFO - 2015-11-19 19:15:22,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 141635584 19:15:22 INFO - 2015-11-19 19:15:22,225 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51401/tests/v8_7/run.html (next: http://localhost:51401/tests/v8_7/run.html) 19:15:43 INFO - 2015-11-19 19:15:43,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 138821632 19:15:43 INFO - 2015-11-19 19:15:43,901 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,902 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:15:43 INFO - 2015-11-19 19:15:43,902 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |0;Richards;166.75004168751042 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.57336430507164 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 19:15:43 INFO - 2015-11-19 19:15:43,903 DEBUG : BROWSER_OUTPUT: |5;Earley;697.350069735007 19:15:43 INFO - 2015-11-19 19:15:43,904 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 19:15:43 INFO - 2015-11-19 19:15:43,904 DEBUG : BROWSER_OUTPUT: |7;RegExp;25600 19:15:43 INFO - 2015-11-19 19:15:43,904 DEBUG : BROWSER_OUTPUT: |8;Splay;593.4718100890208 19:15:43 INFO - 2015-11-19 19:15:43,904 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 19:15:43 INFO - 2015-11-19 19:15:43,904 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: __startTimestamp1447989343901__endTimestamp 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,905 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,906 DEBUG : BROWSER_OUTPUT: Values: 166.8 19:15:43 INFO - 2015-11-19 19:15:43,906 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,906 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.57 Median:193.57 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,906 DEBUG : BROWSER_OUTPUT: Values: 193.6 19:15:43 INFO - 2015-11-19 19:15:43,907 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,907 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,907 DEBUG : BROWSER_OUTPUT: Values: 285.1 19:15:43 INFO - 2015-11-19 19:15:43,907 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,908 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,908 DEBUG : BROWSER_OUTPUT: Values: 5040.2 19:15:43 INFO - 2015-11-19 19:15:43,908 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: Values: 1056.0 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.35 Median:697.35 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: Values: 697.4 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: Values: 12120.5 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25600.00 Median:25600.00 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,909 DEBUG : BROWSER_OUTPUT: Values: 25600.0 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.47 Median:593.47 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: Values: 593.5 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: Values: 4835.7 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:15:43 INFO - 2015-11-19 19:15:43,910 DEBUG : BROWSER_OUTPUT: 19:15:44 INFO - 2015-11-19 19:15:44,917 INFO : Browser exited with error code: 0 19:15:44 INFO - 2015-11-19 19:15:44,932 INFO : Completed test v8_7 (00:00:40) 19:15:44 INFO - 2015-11-19 19:15:44,942 INFO : Completed test suite (00:20:11) 19:15:44 INFO - 2015-11-19 19:15:44,942 DEBUG : Working with test: dromaeo_css 19:15:44 INFO - 2015-11-19 19:15:44,942 DEBUG : Generating results file: dromaeo_css 19:15:44 INFO - 2015-11-19 19:15:44,944 DEBUG : Working with test: kraken 19:15:44 INFO - 2015-11-19 19:15:44,944 DEBUG : Generating results file: kraken 19:15:44 INFO - 2015-11-19 19:15:44,944 INFO : javascript benchmark 19:15:44 INFO - 2015-11-19 19:15:44,944 DEBUG : Working with test: v8_7 19:15:44 INFO - 2015-11-19 19:15:44,945 DEBUG : Generating results file: v8_7 19:15:44 INFO - 2015-11-19 19:15:44,945 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:15:44 INFO - 2015-11-19 19:15:44,996 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 19:15:44 INFO - 2015-11-19 19:15:44,997 DEBUG : process_Request line: dromaeo_css 6936.04 graph.html#tests=[[72,1,43]] 19:15:44 INFO - 2015-11-19 19:15:44,997 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:15:45 INFO - 2015-11-19 19:15:45,102 DEBUG : process_Request line: kraken 1523.70 graph.html#tests=[[232,1,43]] 19:15:45 INFO - 2015-11-19 19:15:45,102 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:15:45 INFO - 2015-11-19 19:15:45,140 DEBUG : process_Request line: v8_7 21435.68 graph.html#tests=[[230,1,43]] 19:15:45 INFO - 2015-11-19 19:15:45,141 INFO : javascript benchmark 19:15:45 INFO - 2015-11-19 19:15:45,144 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3190.5214217867315, 3249.285157265402, 3275.8689652413905, 3282.474804031354, 3315.4529502632076, 5278.313819203508, 5387.218853266274, 5439.673619582828, 5441.755121019559, 5446.673199608022, 5403.972980135104, 5454.836354909349, 5461.208124821898, 5493.423190564993, 5504.972475137619, 4661.230896902007, 4900.460949295574, 5080.517350851663, 5100.362454693163, 5100.464451232623, 4890.73100979446, 5063.316452278932, 5082.0, 5143.742812859361, 5170.870728231786, 4950.925736113961, 4982.87542811429, 4997.50024997501, 5016.673916195436, 5029.899402011939, 4947.084789313988, 4980.0, 4982.651214414992, 5010.924836127461, 5018.347614810088, 4869.63477739171, 4890.290907818347, 4934.062528119646, 4952.455229924705, 4978.029284289565, 5167.431582525919, 5207.244949482304, 5226.346706661668, 5238.266642670029, 5296.126139187029, 5925.703714814285, 5933.940660593382, 5934.673592952386, 5940.227770389865, 5960.552958528085, 5848.561357898175, 5875.529957603381, 5942.108683697436, 5950.404959504058, 5976.372480889531, 5551.750171242304, 5612.270404847425, 5618.578606604521, 5631.211630371751, 5647.519960803336, 6040.0, 6043.879122417615, 6082.787102451393, 6104.786332478342, 6108.450239478469, 5685.346185188673, 5784.161296611967, 5818.127280907897, 5890.175375447441, 5902.527797776168, 5887.2052272943465, 5900.055991041499, 5902.321233058167, 5925.348211696796, 5943.078822782476, 5852.356240813507, 5885.793997210077, 5888.5289176865745, 5892.616979896293, 5892.646441213456, 5739.971300143473, 5794.739236734357, 5802.535797136219, 5889.676067816311, 5898.203742494794, 4486.304622783474, 4498.910021799546, 4503.594676479132, 4525.841595544141, 4545.545445455494, 3971.3050216212046, 3991.261616600938, 3999.8000099994883, 4027.1140349123148, 4075.4090656855183, 5395.379531353866, 5514.09017512106, 5524.696141712245, 5569.248151499577, 5617.494425501724, 5880.0, 5917.142014407887, 5920.259967504062, 5925.525957923356, 5951.107333899863, 5426.511613954763, 5531.0, 5554.6944918029085, 5587.7485513152005, 5606.187102870061, 5009.824656137091, 5082.949170508247, 5083.059633967728, 5086.287919691246, 5138.2292656101135, 6121.969390153021, 6139.048447490646, 6139.907901381483, 6144.324124346229, 6158.261008678987, 5742.138679198154, 5945.435183657545, 5953.940460595339, 5955.821325360246, 5957.940420595912, 5977.880442391215, 6089.847753806191, 6098.371716891094, 6102.852830488404, 6107.114468401968, 5685.857853553694, 5815.214945982408, 5854.502367298657, 5858.619189752652, 5869.325027621708, 5782.335031471434, 5919.704014799329, 5925.081612350093, 5943.078822782476, 5953.851153721192, 5715.028445164416, 5780.21967034445, 5782.074868021096, 5789.1895134680335, 5822.155787410887, 5825.446582574648, 5831.154482599914, 5840.357560668238, 5841.50347220491, 5844.94155058444, 5455.563554915677, 5489.890202195854, 5587.3015873015875, 5735.197072409949, 5763.94236057634, 5770.365259821332, 5810.302763668386, 5843.824685259449, 5845.736941837543, 5849.912251316148, 5692.0, 5720.141978703062, 5738.053221218453, 5739.770409183586, 5740.0], "unit": "ms", "name": "dojo.html", "value": 5427.7617431338795}, {"lowerIsBetter": false, "replicates": [554.4400155842598, 591.2018774654217, 593.8456001439624, 601.5638661970071, 649.2663290481755, 29676.10971670848, 39236.21527569447, 39620.0, 39855.0, 39890.8005459973, 40901.7954910225, 41394.17211655765, 41443.0, 41473.79263103688, 41500.169996600125, 8608.827823443544, 8808.867866982, 8814.64741410346, 8860.113988601153, 8883.95558022209, 8558.186972237627, 8649.481031138152, 8653.740387788377, 8713.912860871405, 8740.169683880022, 8684.8697269541, 8725.345599080063, 8728.214460698537, 8759.211670949613, 8776.736697899041, 8608.741737747878, 8634.654613815472, 8651.178138076904, 8701.912980870173, 8728.825423491558, 8566.357523185787, 8574.142585741438, 8670.306375489945, 8685.826283474295, 8696.260817830429, 37784.81107594472, 38481.0, 38488.80755596232, 38620.42069368934, 38670.61329386698, 3223.1458663454205, 3228.6448490666007, 3300.488424294238, 3378.4256676365076, 3586.605473397924, 28793.42413151725, 28832.567511487134, 29037.56443653347, 29622.25944351387, 30275.545866812015, 3869.690424766012, 3921.0, 3949.447077409165, 4021.8994525136814, 4037.5147008990116, 252364.0, 253558.99999999817, 253958.0, 254273.0, 254767.0, 54419.72790136024, 54421.45578544243, 54622.0, 54757.45242547603, 54762.72618636961, 67425.32574674289, 68947.65526172437, 68997.65501172462, 69046.0, 69165.65417172882, 14695.485658001919, 14807.963442559132, 14836.70326593462, 14891.776623350659, 14998.175100369366, 12178.695532611755, 12406.62780116598, 12417.192882462792, 12496.437660305308, 12508.49966001368, 19762.604747904963, 20106.69839952402, 20197.798022019884, 20273.594528109355, 20308.492287692632, 8132.227438393344, 8267.255946964682, 8286.378521610903, 8295.502269863828, 8309.210624990737, 916.4547094478775, 935.8830146231721, 1020.1787561013456, 1052.7894421115654, 1131.2364154195884, 27089.86455067712, 27584.724152758616, 27606.861965690445, 27852.16443506698, 31906.36187276288, 987.2644879564771, 1023.5752162852333, 1033.1476531861244, 1071.2287153249647, 1123.7303047268597, 14588.41646334156, 14602.74369095803, 14796.112233266038, 14958.925205373904, 15017.849821501864, 376799.0, 381268.0, 381985.0, 383547.0, 383556.0, 49759.0, 50357.49642503601, 50393.49606503962, 50539.49460505348, 50600.0, 1326.290434617475, 1328.9468421263234, 1334.6996925691835, 1336.1181620130667, 1346.9326533673277, 26732.331691707863, 27574.172774816787, 27835.860820696576, 27986.300342491602, 28003.0, 42596.0, 42979.785101074296, 43064.35403469013, 43211.35182972321, 43224.0, 288838.0, 290081.0, 290749.0, 290983.0, 292577.0, 30608.0, 42090.15819683528, 42670.35994460023, 43007.354889677306, 43025.13949720925, 47602.76198618985, 48517.27224091712, 48881.755591221816, 49061.50938490712, 49242.507574923795, 35705.46441803427, 36065.27869442544, 36177.819110904275, 37034.629653703116, 37270.62729372671, 35487.29025419425, 36087.819560902026, 36198.8190059048, 36282.274354512236, 36319.09202269858, 38970.2205955885, 39459.60540394559, 39707.205855882145, 39734.80132599434, 40150.79924600358, 30465.0, 31066.68933310638, 33448.0, 33714.494282586274, 33860.492092619126, 25158.24525264245, 25689.378229323687, 25802.0, 25806.0, 26045.348866278495], "unit": "ms", "name": "ext.html", "value": 18755.459718216698}, {"lowerIsBetter": false, "replicates": [349.53860903607233, 355.87722235828636, 358.1366971066322, 358.1583279293662, 362.3351150638578, 16313.836861631395, 16685.41601043962, 17351.305947762106, 17479.388221412253, 18154.0, 10885.945570272137, 11859.644210673672, 15582.844171558281, 15812.683746325096, 15850.84149158508, 4588.655850811186, 4981.476944920785, 4984.252362145689, 4987.950120498803, 4999.500049994989, 4897.1674815281485, 4961.429435614915, 4963.156263435225, 4971.825986090487, 4988.152014157584, 4980.750962451881, 5025.1708468102715, 5040.697558146505, 5095.847124586268, 5327.893442131155, 4983.975080124613, 5069.036882992256, 5080.847574572768, 5087.5421212090905, 5099.770510327045, 4857.73282469464, 5298.92051619226, 5327.893442131174, 5343.0, 5352.57179425645, 12365.752684946341, 12564.120511564193, 14202.431902723878, 20847.478813029644, 20868.373948781562, 2049.8975051247526, 2095.3609149209483, 2109.514811593342, 2154.2567814104264, 2252.831037672181, 9411.105944935289, 9686.418814871131, 10222.0289072538, 10327.431991240479, 13193.0, 1778.7776527934009, 1799.1364145210373, 1836.9816301837077, 1844.8708590398678, 1896.2225487550038, 58839.70580147072, 60383.69808150975, 61184.0, 61195.0, 61797.0, 9849.162821160282, 10022.849657255147, 10087.092161705335, 10101.646442374482, 10269.897301026895, 13282.003849711311, 13338.466461341632, 13390.263535505446, 13413.0610857241, 13467.12463689857, 7417.7774666759005, 7496.400287976949, 7563.810904727426, 7746.961265193638, 7869.1737367576725, 7128.6435678215885, 7148.785536433916, 7227.5302105364035, 7252.492325537267, 7266.564006159648, 4343.0, 4356.542563030899, 4393.055493069006, 4393.231184542756, 4461.933071003938, 1760.5651394113756, 1791.167107295114, 1799.388208009257, 1811.4022372617005, 1815.0743121008381, 380.52244433236666, 387.179180138109, 390.87882756345056, 397.4614397491415, 941.6327632223438, 8820.779480513038, 9314.34799564024, 9632.855507167398, 9649.372790768577, 10117.836448808333, 368.18814513996574, 369.1435868784448, 385.1545856844256, 416.7707760731586, 426.0584109118882, 5450.236966824647, 5483.616146869681, 5554.1391084381985, 5569.303837020372, 5617.32592088952, 502702.0, 505516.0, 512843.0, 531703.0, 536604.0, 70124.0, 74295.0, 76037.23962760413, 77529.22470775332, 78392.60803695946, 1144.605111236622, 1155.0759392486145, 1167.7255844876618, 1169.5263418315596, 1174.6358628825092, 14750.483733069292, 14938.551843444715, 14996.475123371067, 15082.54752357431, 15417.383304668136, 31458.52812207773, 31961.36077278488, 32839.50740738843, 33005.66994330122, 36490.452643210905, 44872.55127448814, 45741.771291144665, 48242.75878620584, 52131.0, 53277.0, 14289.71420571562, 15154.696906062038, 15222.391104355702, 15249.313780879666, 15501.922490387477, 18062.90968545149, 18153.45539633813, 18668.626627467645, 18802.811971880106, 18854.151563179963, 9094.499802510925, 9157.725268241964, 9374.203192728695, 9476.668316608886, 9535.23718102564, 8775.692850750193, 8946.463212207289, 9042.412243204171, 9120.680776172801, 9192.402493837879, 9356.766080848034, 9532.285078618992, 9544.33189676716, 9547.665831695856, 9588.76028099303, 14311.499097531536, 14786.778198326818, 15022.0, 15074.0, 15329.233538323262, 9064.274858011475, 9239.72280831576, 9423.340366174576, 15720.764188536952, 15903.125328107066], "unit": "ms", "name": "jquery.html", "value": 7984.366942055048}, {"lowerIsBetter": false, "replicates": [1477.7635578307459, 1556.7275726747816, 1560.9921950390246, 1634.8773841961852, 1705.1900347335018, 7052.823679408018, 7326.120865496135, 7370.5577665340115, 7373.594452305121, 7581.128170260422, 7429.257074292568, 7455.701771929116, 7512.060992375953, 7527.059117610299, 7535.924640753591, 2196.1105752170356, 2214.6567282071305, 2217.2128894242555, 2219.0901730290584, 2226.3432287475152, 2229.944251393712, 2270.9545809083806, 2272.068451934707, 2284.8286378521593, 2293.2776175504746, 2127.936161915145, 2161.243564752332, 2172.945676358088, 2196.0, 2221.866687998717, 2186.147402513021, 2209.171560664751, 2220.4226901005854, 2231.8995645196005, 2242.3273018094505, 2250.786175313359, 2263.343630347214, 2271.193726227182, 2272.7954484096513, 2274.5678321118935, 7281.5631062136445, 7296.270372962715, 7355.37479314259, 7369.078865141857, 7403.4447416443445, 4451.065276291983, 4509.143262780061, 4537.773111344452, 4545.568171023748, 4556.817727290904, 2970.4801659709465, 3060.8928687496054, 3072.9539056914164, 3073.2624170199215, 3098.4732595458827, 1023.5752162852407, 1032.6747074671455, 1049.7060822969581, 1068.8717353917502, 1072.587053984214, 10027.448490332956, 10079.395236285847, 10166.745831354201, 10168.79662406755, 10176.0, 3929.76421414716, 3935.58676338986, 3956.8615098471414, 4013.4381186633896, 4081.5102187737066, 8315.168483151758, 8343.541105239148, 8364.912561366984, 8432.620532076071, 8436.072032076467, 4514.61625761814, 4534.9319760203625, 4538.2738761797955, 4545.250033744395, 4551.499335073139, 4182.456280683553, 4195.223883581547, 4205.222033923673, 4210.810513526899, 4236.025714085716, 3260.5924259467565, 3292.654271301527, 3303.8678452862096, 3328.5007248912857, 3329.93340133196, 1027.7584767579613, 1045.10643399892, 1046.3512622174148, 1061.4586560853866, 1061.4851796878509, 1017.8218811708069, 1032.5353590884133, 1085.5277954089995, 1126.898579127866, 1231.0643910627807, 6920.377166055079, 6924.23833378328, 6940.618265995418, 6963.895541566881, 6976.895346569806, 1173.1318824070297, 1176.147293212414, 1178.1635039122318, 1185.5613423033533, 1222.2238878312335, 5616.157576363496, 5644.096944488862, 5646.85882852932, 5653.378128405872, 5654.802081927195, 8651.567421628893, 8747.737567872973, 8758.47449153053, 8779.648814047367, 8849.60176792046, 7656.119546252252, 7671.6164191790185, 7673.309402153833, 7682.078150621961, 7702.229777022253, 6950.235474097845, 6967.756128535477, 6980.7905762827195, 7033.261507541634, 7038.92961070393, 6922.550034247758, 6936.237013928565, 6941.757038503628, 7005.334493223136, 7012.544184627983, 7794.259545343183, 7936.761897143095, 7939.722109726363, 7951.562664053533, 7982.401319901147, 8026.518408895485, 8092.433529652868, 8191.344692424473, 8194.0, 8223.95888020556, 6933.168019837652, 6995.720171193096, 7192.0, 7219.45854060937, 7219.747308844166, 7075.752348667772, 7186.89219661695, 7188.065551478275, 7196.460265480215, 7197.0, 6755.662216889037, 6840.863182736218, 6844.794656160323, 6979.581225126509, 7022.964885175541, 6624.966875165594, 6662.467002639681, 6678.933210667831, 6799.728010879509, 6825.624590647363, 6803.897941530782, 6956.582605043714, 6988.755393561201, 7011.824704382431, 7012.544184627983, 6263.6241825490615, 6366.395192456709, 6376.904346434714, 6382.648954307558, 6385.904211436925, 6282.811515654537, 6290.748370065329, 6343.207099112611, 6345.904811427925, 6368.808935731936], "unit": "ms", "name": "mootools.html", "value": 4329.2917967542635}, {"lowerIsBetter": false, "replicates": [327.7459968524395, 330.53229680002795, 331.8473502188993, 333.76803121830335, 336.8198014062476, 6343.397377249165, 6348.111264422984, 6350.523710721697, 6368.681565921703, 6496.642684652342, 6272.153259309992, 6300.5589608727405, 6314.810555683325, 6315.589486683374, 6323.74705011799, 4732.1482133216, 4737.881552961169, 4756.66703330767, 4762.880927976794, 4764.999350136475, 4747.928781068269, 4748.857534273978, 4755.9286610700865, 4770.212914869043, 4772.642051846108, 4640.3967484227005, 4800.159972004903, 4801.831935882245, 4803.591694705954, 4809.711417314955, 4772.832950846721, 4783.115123702109, 4787.234042553209, 4798.592119669832, 4805.687630304019, 4158.6465150462245, 4159.604837540429, 4161.979190104061, 4176.0, 4179.226843034048, 5973.8805223895715, 5993.940060599425, 5994.310654274771, 5995.730192141321, 6009.248843894513, 5387.218853266294, 5460.6177567570285, 5471.890562188734, 5472.863178420572, 5481.424450432727, 6701.765438209688, 6710.429613482811, 6732.461403087741, 6736.2590115087305, 6739.326067393271, 4454.443194600675, 4458.464984201884, 4464.241079016575, 4467.977660111711, 4477.552244775529, 6754.898676519856, 6888.758893438756, 6938.930610693929, 6950.5482143661, 6975.128108986377, 4645.837395691135, 4651.09303685778, 4651.674382793172, 4653.883652908705, 4656.813727450932, 4683.812647494062, 4686.742229177428, 4692.835750748707, 4699.765011749399, 4721.362616046789, 5496.615236933456, 5502.422245664227, 5504.311961004874, 5510.91733623996, 5527.281453411031, 6616.536842420985, 6714.060031595581, 6724.596524208465, 6738.292479289604, 6795.592264464148, 1628.9185540722917, 1671.7158083125655, 1688.4681325382464, 1689.5944973206588, 1694.2883988724766, 1122.0967121467297, 1143.2511704833348, 1153.313778301909, 1164.8019836627793, 1175.6473058082713, 6360.268569114519, 6421.614703117734, 6422.261439934374, 6432.51756118293, 6435.806925792233, 6813.591184528944, 6817.625030623264, 6843.965780171166, 6846.178458585002, 6862.3823855852215, 6308.589941653778, 6325.65208913505, 6366.936330636634, 6368.235811702625, 6397.072424498421, 3791.5071040764524, 3796.032011837019, 3812.6568608825337, 3815.7901315427916, 3816.3130636485143, 7200.171980222237, 7224.891626625605, 7247.16657584374, 7256.6734496947765, 7266.346028857428, 7028.683709233097, 7174.856502869913, 7175.103112110986, 7186.461015423864, 7198.0, 7216.567005979553, 7217.422606191387, 7262.745803896838, 7280.0535930328715, 7295.088113985752, 6976.127984002, 7010.298970102949, 7019.789406317818, 7031.08595882532, 7035.648217589202, 6739.46084313244, 6963.373296403348, 6970.0, 6970.442364610921, 6987.475939304471, 7295.963520182578, 7300.744473943387, 7301.488895777245, 7302.123745150616, 7310.96344518274, 4683.34433179362, 4722.890120821673, 4724.362211101457, 4728.31439441286, 4731.739754313546, 6748.089007983859, 6784.626845523544, 6920.5847649141215, 6956.991236270611, 6963.234044255027, 6734.528582999143, 6752.08846805675, 6759.662016899234, 6832.214295356098, 6849.554778939353, 6725.831854203489, 6743.865122697617, 6754.696038678173, 6780.423439093311, 6801.421879140328, 6510.609363438209, 6653.667316634052, 6655.168103987002, 6657.06801047844, 6668.866622667422, 6760.695768690519, 6797.966010169917, 6811.795646130624, 6812.829679258059, 6824.044633751378, 6630.403263706096, 6640.734370625121, 6664.8000559983275, 6673.566218195801, 6676.732930682719], "unit": "ms", "name": "prototype.html", "value": 5038.977340884564}, {"lowerIsBetter": false, "replicates": [742.2429122295259, 791.4064451661254, 808.5754978636215, 840.2899549880353, 842.9873551896719, 14135.78796318056, 14512.927435362835, 14563.85436145641, 14597.635059123513, 14616.26918654067, 13493.257870817126, 13562.389692463837, 13573.932130339335, 13614.0, 13617.182969021866, 803.1887793328751, 820.4994953078617, 830.7341650671788, 832.92087251711, 835.2941764209233, 819.491915012693, 829.179112678447, 831.4138532334689, 831.9958400208021, 832.1512057701141, 849.6771226933787, 858.3176374782063, 858.356232825381, 862.779991102268, 863.2619110660389, 845.5983407881268, 845.8139209373959, 850.8638617821181, 851.9574021298911, 853.7097386888456, 627.1126356206008, 627.9560430769848, 630.5995692735146, 631.6147150238351, 632.7911789109629, 13362.131461454974, 13440.731185376335, 13480.5281815136, 13541.255230962293, 13564.186148831002, 12147.878521214763, 12166.391680415943, 12536.686582835411, 12542.828384000133, 12567.622971310784, 10541.0, 10832.295900766425, 10884.782304353948, 11361.43192840363, 11861.347625880573, 3646.6535679110443, 3720.330340538702, 3721.7208709346905, 3734.1598140418187, 3854.4411060396365, 45601.771991140165, 46168.3074753879, 46274.30588541175, 46300.07399852018, 46435.76782116102, 10046.0, 10187.388756674623, 10657.467126643636, 10846.945765271123, 10870.076043536388, 19003.80996190048, 19085.427437176906, 19178.80821191798, 19192.904035480013, 19224.0, 7475.168583697029, 7486.588237646873, 7606.201348858401, 7702.152763196044, 7757.1079325878245, 4098.221337945781, 4304.82780688769, 4380.364847097153, 4420.160169567772, 4450.910981780346, 3027.8031927924612, 3057.29682173097, 3062.096681478969, 3062.372213696187, 3065.3103051813164, 586.61576667283, 590.5452801342942, 598.2730981856978, 598.964062156272, 599.0325624117106, 631.8704665543553, 662.8144119646506, 673.8618583190532, 686.615495322621, 691.8339598496325, 7933.167017463199, 8065.233802788725, 8090.352771778244, 8119.634616442274, 8199.7950051248, 534.3374215972244, 655.0828839624563, 659.0378048049805, 669.2588430672564, 676.1818199977984, 3674.3202507536193, 3680.0, 3709.4806727058235, 3753.249350129985, 3754.662080412776, 51898.0, 56156.438435615935, 59247.40752592505, 59264.0, 59319.0, 47058.5294147061, 47179.76410117927, 47305.0, 47816.0, 48368.0, 45963.0, 46616.533834661896, 47150.76424617855, 47199.292010619865, 47396.99999999931, 8075.878861817195, 8206.466579672302, 8293.626786794488, 8419.0, 8439.493630382196, 34152.31695366029, 34270.657293426746, 34667.826660866536, 34861.0, 34942.12644683802, 41155.58844411517, 41307.0, 45865.54134458746, 45900.31149532693, 46293.768531157126, 10438.802297373315, 10734.0, 10858.45707714627, 10969.83545246806, 11121.16591255643, 11082.0, 11431.142664300045, 11516.0, 11635.47640356169, 11826.940865295619, 10568.959488485816, 10693.786124277316, 10730.302530335503, 10734.83897741519, 10978.945105274743, 10837.349759014485, 10853.34879907208, 11068.501917413896, 11133.832992504957, 11468.770624587294, 10096.242781791248, 10152.644657436955, 10418.218633602359, 10497.52761125736, 11159.10727141843, 9289.72130836076, 9400.0, 9404.0, 9645.228381729305, 9717.951410242904, 8687.522186279815, 8821.955890220765, 9138.497382644018, 9212.0, 9234.538273086453], "unit": "ms", "name": "yui.html", "value": 6278.888797597328}], "name": "dromaeo_css", "value": 6936.03743209422}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 103.0, 112.0, 111.0, 113.0, 126.0, 110.0, 112.0, 111.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 154.0, 165.0, 133.0, 157.0, 160.0, 129.0, 167.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 164.0, 165.0, 160.0, 163.0, 165.0, 171.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 73.0, 73.0, 138.0, 75.0, 73.0, 73.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 147.0, 92.0, 93.0, 92.0, 148.0, 90.0, 91.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 98.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 69.0, 66.0, 67.0, 66.0, 68.0, 63.0, 63.0], "unit": "ms", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 93.0, 85.0, 84.0, 85.0, 85.0, 94.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 115.0, 121.0, 128.0, 132.0, 119.0, 115.0, 134.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 150.0, 158.0, 154.0, 144.0, 142.0, 150.0, 154.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 69.0, 70.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1523.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [193.57336430507164], "unit": "score", "name": "DeltaBlue", "value": 341.56558799999993}, {"lowerIsBetter": false, "replicates": [285.143997718848], "unit": "score", "name": "Encrypt", "value": 933.4967669999996}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [697.350069735007], "unit": "score", "name": "Earley", "value": 955.7079420000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [25600.0], "unit": "score", "name": "RegExp", "value": 35.58535156250002}, {"lowerIsBetter": false, "replicates": [593.4718100890208], "unit": "score", "name": "Splay", "value": 137.31233500000002}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21435.679363810657}]} 19:15:45 INFO - RETURN: dromaeo_css: 6936.04 19:15:45 INFO - RETURN: kraken: 1523.70 19:15:45 INFO - RETURN: v8_7: 21435.68 19:15:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21435.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1523.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6936.04"}}} 19:15:45 INFO - Return code: 0 19:15:45 INFO - # TBPL SUCCESS # 19:15:45 INFO - Running post-action listener: _resource_record_post_action 19:15:45 INFO - Running post-run listener: _resource_record_post_run 19:15:46 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516902912; Read time: 12; Write time: 560700 19:15:46 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 146104320; Read time: 0; Write time: 295832 19:15:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 370798592; Read time: 12; Write time: 264868 19:15:46 INFO - Running post-run listener: _upload_blobber_files 19:15:46 INFO - Blob upload gear active. 19:15:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:15:46 INFO - Copying logs to upload dir... 19:15:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1298.639701 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2015-11-19 19:15:45.177383) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 19:15:45.181183) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009975 build_url: 'https://queue.taskcluster.net/v1/task/9VoIBK9UQ5-wrtyBkZQtmw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 19:15:45.233171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 19:15:45.233503) ========= 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=3cd289541638898829117e0a000001bd-1447978710.946339-1240195199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 19:15:45.282543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 19:15:45.282863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 19:15:45.283188) ========= ========= Total master_lag: 0.22 =========