builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1455559527.24 results: success (0) buildid: 20160215074422 builduid: e030000212d64f56a66c1565bd11007f revision: b46a67b9666b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.242500) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.242997) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.243437) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004817 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.296199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.296621) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.338888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.339192) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.049412 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.400208) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.400562) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.400971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.401309) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 10:05:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.0M=0s 2016-02-15 10:05:27 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.269279 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.683252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.683612) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037384 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.733538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:27.733946) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b46a67b9666b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b46a67b9666b --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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 10:05:27,786 Setting DEBUG logging. 2016-02-15 10:05:27,787 attempt 1/10 2016-02-15 10:05:27,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b46a67b9666b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 10:05:28,056 unpacking tar archive at: mozilla-beta-b46a67b9666b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598684 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:28.345211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:28.345597) ========= echo b46a67b9666b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b46a67b9666b'] 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b46a67b9666b program finished with exit code 0 elapsedTime=0.003795 script_repo_revision: 'b46a67b9666b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:28.394493) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:28.394855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 10:05:28.405192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-15 10:05:28.405516) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:28 INFO - MultiFileLogger online at 20160215 10:05:28 in /builds/slave/test-pgo 10:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:05:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:05:28 INFO - {'append_to_log': False, 10:05:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:05:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:05:28 INFO - 'branch': 'Mozilla-Beta', 10:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:28 INFO - 'config_files': ('talos/linux_config.py',), 10:05:28 INFO - 'default_actions': ('clobber', 10:05:28 INFO - 'read-buildbot-config', 10:05:28 INFO - 'download-and-extract', 10:05:28 INFO - 'populate-webroot', 10:05:28 INFO - 'create-virtualenv', 10:05:28 INFO - 'install', 10:05:28 INFO - 'run-tests'), 10:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:28 INFO - 'download_minidump_stackwalk': True, 10:05:28 INFO - 'download_symbols': 'ondemand', 10:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:28 INFO - 'installer_path': 'installer.exe', 10:05:28 INFO - 'log_level': 'info', 10:05:28 INFO - 'log_name': 'talos', 10:05:28 INFO - 'log_to_console': True, 10:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:28 INFO - 'opt_config_files': (), 10:05:28 INFO - 'pip_index': False, 10:05:28 INFO - 'sps_profile': False, 10:05:28 INFO - 'sps_profile_interval': 0, 10:05:28 INFO - 'suite': 'dromaeojs', 10:05:28 INFO - 'system_bits': '32', 10:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:28 INFO - 'title': 'talos-linux64-ix-033', 10:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:28 INFO - 'use_talos_json': True, 10:05:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:28 INFO - 'work_dir': 'build'} 10:05:28 INFO - ##### 10:05:28 INFO - ##### Running clobber step. 10:05:28 INFO - ##### 10:05:28 INFO - Running pre-action listener: _resource_record_pre_action 10:05:28 INFO - Running main action method: clobber 10:05:28 INFO - rmtree: /builds/slave/test-pgo/build 10:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:05:34 INFO - Running post-action listener: _resource_record_post_action 10:05:34 INFO - ##### 10:05:34 INFO - ##### Running read-buildbot-config step. 10:05:34 INFO - ##### 10:05:34 INFO - Running pre-action listener: _resource_record_pre_action 10:05:34 INFO - Running main action method: read_buildbot_config 10:05:34 INFO - Using buildbot properties: 10:05:34 INFO - { 10:05:34 INFO - "properties": { 10:05:34 INFO - "buildnumber": 122, 10:05:34 INFO - "product": "firefox", 10:05:34 INFO - "script_repo_revision": "production", 10:05:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:05:34 INFO - "repository": "", 10:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:05:34 INFO - "buildid": "20160215074422", 10:05:34 INFO - "slavename": "talos-linux64-ix-033", 10:05:34 INFO - "pgo_build": "True", 10:05:34 INFO - "basedir": "/builds/slave/test-pgo", 10:05:34 INFO - "project": "", 10:05:34 INFO - "platform": "ubuntu64_hw", 10:05:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:05:34 INFO - "slavebuilddir": "test", 10:05:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:05:34 INFO - "branch": "mozilla-beta", 10:05:34 INFO - "repo_path": "releases/mozilla-beta", 10:05:34 INFO - "stage_platform": "linux64-pgo", 10:05:34 INFO - "builduid": "e030000212d64f56a66c1565bd11007f", 10:05:34 INFO - "revision": "b46a67b9666b" 10:05:34 INFO - }, 10:05:34 INFO - "sourcestamp": { 10:05:34 INFO - "repository": "", 10:05:34 INFO - "hasPatch": false, 10:05:34 INFO - "project": "", 10:05:34 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:05:34 INFO - "changes": [ 10:05:34 INFO - { 10:05:34 INFO - "category": null, 10:05:34 INFO - "files": [ 10:05:34 INFO - { 10:05:34 INFO - "url": null, 10:05:34 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:05:34 INFO - } 10:05:34 INFO - ], 10:05:34 INFO - "repository": "", 10:05:34 INFO - "rev": "b46a67b9666b", 10:05:34 INFO - "who": "sendchange", 10:05:34 INFO - "when": 1455559502, 10:05:34 INFO - "number": 7606440, 10:05:34 INFO - "comments": "Bug 1246938 - Allow extra headers to be passed via hawk requests. r=markh,a=sledru", 10:05:34 INFO - "project": "", 10:05:34 INFO - "at": "Mon 15 Feb 2016 10:05:02", 10:05:34 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:05:34 INFO - "revlink": "", 10:05:34 INFO - "properties": [ 10:05:34 INFO - [ 10:05:34 INFO - "buildid", 10:05:34 INFO - "20160215074422", 10:05:34 INFO - "Change" 10:05:34 INFO - ], 10:05:34 INFO - [ 10:05:34 INFO - "builduid", 10:05:34 INFO - "e030000212d64f56a66c1565bd11007f", 10:05:34 INFO - "Change" 10:05:34 INFO - ], 10:05:34 INFO - [ 10:05:34 INFO - "pgo_build", 10:05:34 INFO - "True", 10:05:34 INFO - "Change" 10:05:34 INFO - ] 10:05:34 INFO - ], 10:05:34 INFO - "revision": "b46a67b9666b" 10:05:34 INFO - } 10:05:34 INFO - ], 10:05:34 INFO - "revision": "b46a67b9666b" 10:05:34 INFO - } 10:05:34 INFO - } 10:05:34 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:05:34 INFO - Running post-action listener: _resource_record_post_action 10:05:34 INFO - ##### 10:05:34 INFO - ##### Running download-and-extract step. 10:05:34 INFO - ##### 10:05:34 INFO - Running pre-action listener: _resource_record_pre_action 10:05:34 INFO - Running main action method: download_and_extract 10:05:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/test_packages.json 10:05:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:05:34 INFO - Downloaded 1270 bytes. 10:05:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:05:34 INFO - Using the following test package requirements: 10:05:34 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:05:34 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:05:34 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'jsshell-linux-x86_64.zip'], 10:05:34 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:05:34 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:05:34 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:05:34 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:05:34 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:05:34 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:05:34 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:05:34 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:05:34 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:34 INFO - Downloaded 21582132 bytes. 10:05:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:05:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:05:35 INFO - Return code: 0 10:05:35 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:05:35 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')]} 10:05:35 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:35 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:05:36 INFO - Downloaded 21582132 bytes. 10:05:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:05:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:05:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:05:38 INFO - Return code: 0 10:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:05:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:05:38 INFO - Downloaded 11132038 bytes. 10:05:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:05:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:05:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:05:38 INFO - Return code: 0 10:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:05:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:05:45 INFO - Downloaded 57949547 bytes. 10:05:45 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:05:45 INFO - mkdir: /builds/slave/test-pgo/properties 10:05:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:05:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:05:45 INFO - Contents: 10:05:45 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:05:45 INFO - Running post-action listener: _resource_record_post_action 10:05:45 INFO - Running post-action listener: set_extra_try_arguments 10:05:45 INFO - ##### 10:05:45 INFO - ##### Running populate-webroot step. 10:05:45 INFO - ##### 10:05:45 INFO - Running pre-action listener: _resource_record_pre_action 10:05:45 INFO - Running main action method: populate_webroot 10:05:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:45 INFO - '--tppagecycles', 10:05:45 INFO - '7'], 10:05:45 INFO - 'tests': ['tsvgm']}}, 10:05:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:05:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:05:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'tests': ['damp', 'tps']}, 10:05:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['damp', 'tps']}, 10:05:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:05:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:45 INFO - 'other': {'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'other_l64': {'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'other_nol64': {'tests': ['a11yr', 10:05:45 INFO - 'ts_paint', 10:05:45 INFO - 'tpaint', 10:05:45 INFO - 'sessionrestore', 10:05:45 INFO - 'sessionrestore_no_auto_restore']}, 10:05:45 INFO - 'svgr': {'tests': ['tsvgx', 10:05:45 INFO - 'tsvgr_opacity', 10:05:45 INFO - 'tart', 10:05:45 INFO - 'tscrollx', 10:05:45 INFO - 'cart']}, 10:05:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['tsvgx', 10:05:45 INFO - 'tsvgr_opacity', 10:05:45 INFO - 'tart', 10:05:45 INFO - 'tscrollx', 10:05:45 INFO - 'cart']}, 10:05:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'tests': ['tp5o']}, 10:05:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'talos_options': ['--e10s'], 10:05:45 INFO - 'tests': ['tp5o']}, 10:05:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'talos_options': ['--xperf_path', 10:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:45 INFO - 'tests': ['tp5n']}, 10:05:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:45 INFO - 'talos_options': ['--e10s', 10:05:45 INFO - '--xperf_path', 10:05:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:45 INFO - 'tests': ['tp5n']}}, 10:05:45 INFO - 'talos.zip': {'path': '', 10:05:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:45 INFO - Running post-action listener: _resource_record_post_action 10:05:45 INFO - ##### 10:05:45 INFO - ##### Running create-virtualenv step. 10:05:45 INFO - ##### 10:05:45 INFO - Running pre-action listener: _resource_record_pre_action 10:05:45 INFO - Running main action method: create_virtualenv 10:05:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:05:45 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 10:05:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:05:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:46 INFO - Using real prefix '/usr' 10:05:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:05:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:48 INFO - Installing pip.................done. 10:05:48 INFO - Return code: 0 10:05:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:05:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:05:48 INFO - Using env: {'DISPLAY': ':0', 10:05:48 INFO - 'HOME': '/home/cltbld', 10:05:48 INFO - 'LANG': 'en_US.UTF-8', 10:05:48 INFO - 'LANGUAGE': 'en_US:en', 10:05:48 INFO - 'LOGNAME': 'cltbld', 10:05:48 INFO - 'MAIL': '/var/mail/cltbld', 10:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:48 INFO - 'MOZ_NO_REMOTE': '1', 10:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:48 INFO - 'NO_EM_RESTART': '1', 10:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:48 INFO - 'SHELL': '/bin/bash', 10:05:48 INFO - 'SHLVL': '1', 10:05:48 INFO - 'TERM': 'linux', 10:05:48 INFO - 'TMOUT': '86400', 10:05:48 INFO - 'USER': 'cltbld', 10:05:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:48 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 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 10:05:49 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:05: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')]} 10:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:05:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:05:49 INFO - Using env: {'DISPLAY': ':0', 10:05:49 INFO - 'HOME': '/home/cltbld', 10:05:49 INFO - 'LANG': 'en_US.UTF-8', 10:05:49 INFO - 'LANGUAGE': 'en_US:en', 10:05:49 INFO - 'LOGNAME': 'cltbld', 10:05:49 INFO - 'MAIL': '/var/mail/cltbld', 10:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:49 INFO - 'MOZ_NO_REMOTE': '1', 10:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:49 INFO - 'NO_EM_RESTART': '1', 10:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:49 INFO - 'SHELL': '/bin/bash', 10:05:49 INFO - 'SHLVL': '1', 10:05:49 INFO - 'TERM': 'linux', 10:05:49 INFO - 'TMOUT': '86400', 10:05:49 INFO - 'USER': 'cltbld', 10:05:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:49 INFO - '_': '/tools/buildbot/bin/python'} 10:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:49 INFO - Downloading/unpacking psutil>=0.7.1 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:49 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 10:05:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:51 INFO - Installing collected packages: psutil 10:05:51 INFO - Running setup.py install for psutil 10:05:51 INFO - building 'psutil._psutil_linux' extension 10:05:51 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 10:05:53 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 10:05:53 INFO - building 'psutil._psutil_posix' extension 10:05:53 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 10:05:53 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 10:05:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:53 INFO - Successfully installed psutil 10:05:53 INFO - Cleaning up... 10:05:53 INFO - Return code: 0 10:05:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:05:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:05:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:05:53 INFO - Using env: {'DISPLAY': ':0', 10:05:53 INFO - 'HOME': '/home/cltbld', 10:05:53 INFO - 'LANG': 'en_US.UTF-8', 10:05:53 INFO - 'LANGUAGE': 'en_US:en', 10:05:53 INFO - 'LOGNAME': 'cltbld', 10:05:53 INFO - 'MAIL': '/var/mail/cltbld', 10:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:53 INFO - 'MOZ_NO_REMOTE': '1', 10:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:53 INFO - 'NO_EM_RESTART': '1', 10:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:53 INFO - 'SHELL': '/bin/bash', 10:05:53 INFO - 'SHLVL': '1', 10:05:53 INFO - 'TERM': 'linux', 10:05:53 INFO - 'TMOUT': '86400', 10:05:53 INFO - 'USER': 'cltbld', 10:05:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:53 INFO - '_': '/tools/buildbot/bin/python'} 10:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:53 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 10:05:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:55 INFO - Installing collected packages: mozsystemmonitor 10:05:55 INFO - Running setup.py install for mozsystemmonitor 10:05:55 INFO - Successfully installed mozsystemmonitor 10:05:55 INFO - Cleaning up... 10:05:55 INFO - Return code: 0 10:05:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:05:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:05:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:05:55 INFO - Using env: {'DISPLAY': ':0', 10:05:55 INFO - 'HOME': '/home/cltbld', 10:05:55 INFO - 'LANG': 'en_US.UTF-8', 10:05:55 INFO - 'LANGUAGE': 'en_US:en', 10:05:55 INFO - 'LOGNAME': 'cltbld', 10:05:55 INFO - 'MAIL': '/var/mail/cltbld', 10:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:55 INFO - 'MOZ_NO_REMOTE': '1', 10:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:55 INFO - 'NO_EM_RESTART': '1', 10:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:55 INFO - 'SHELL': '/bin/bash', 10:05:55 INFO - 'SHLVL': '1', 10:05:55 INFO - 'TERM': 'linux', 10:05:55 INFO - 'TMOUT': '86400', 10:05:55 INFO - 'USER': 'cltbld', 10:05:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:55 INFO - '_': '/tools/buildbot/bin/python'} 10:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:55 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:58 INFO - Downloading docopt-0.6.1.tar.gz 10:05:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:58 INFO - Running setup.py install for blobuploader 10:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:05:58 INFO - Running setup.py install for requests 10:05:58 INFO - Running setup.py install for docopt 10:05:59 INFO - Successfully installed blobuploader requests docopt 10:05:59 INFO - Cleaning up... 10:05:59 INFO - Return code: 0 10:05:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:05:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:05:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:59 INFO - Using env: {'DISPLAY': ':0', 10:05:59 INFO - 'HOME': '/home/cltbld', 10:05:59 INFO - 'LANG': 'en_US.UTF-8', 10:05:59 INFO - 'LANGUAGE': 'en_US:en', 10:05:59 INFO - 'LOGNAME': 'cltbld', 10:05:59 INFO - 'MAIL': '/var/mail/cltbld', 10:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:59 INFO - 'MOZ_NO_REMOTE': '1', 10:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:59 INFO - 'NO_EM_RESTART': '1', 10:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:59 INFO - 'SHELL': '/bin/bash', 10:05:59 INFO - 'SHLVL': '1', 10:05:59 INFO - 'TERM': 'linux', 10:05:59 INFO - 'TMOUT': '86400', 10:05:59 INFO - 'USER': 'cltbld', 10:05:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:59 INFO - '_': '/tools/buildbot/bin/python'} 10:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:59 INFO - Running setup.py (path:/tmp/pip-GFXGGG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:59 INFO - Running setup.py (path:/tmp/pip-AcF6LF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:59 INFO - Running setup.py (path:/tmp/pip-vRZkTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:59 INFO - Running setup.py (path:/tmp/pip-kSIkD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:59 INFO - Running setup.py (path:/tmp/pip-7MoS9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:59 INFO - Running setup.py (path:/tmp/pip-srx1co-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:59 INFO - Running setup.py (path:/tmp/pip-Po7vik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:59 INFO - Running setup.py (path:/tmp/pip-IuzXpD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:59 INFO - Running setup.py (path:/tmp/pip-MZ1edS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:05:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:00 INFO - Running setup.py (path:/tmp/pip-Dn0Ezn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:00 INFO - Running setup.py (path:/tmp/pip-QC_yh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:00 INFO - Running setup.py (path:/tmp/pip-NuP6D2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:00 INFO - Running setup.py (path:/tmp/pip-SlNdC8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:00 INFO - Running setup.py (path:/tmp/pip-lea5yh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:00 INFO - Running setup.py (path:/tmp/pip-ce_Jdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:00 INFO - Running setup.py (path:/tmp/pip-qjH8d7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:00 INFO - Running setup.py (path:/tmp/pip-PWHFE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:00 INFO - Running setup.py install for manifestparser 10:06:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:06:00 INFO - Running setup.py install for mozcrash 10:06:00 INFO - Running setup.py install for mozdebug 10:06:00 INFO - Running setup.py install for mozdevice 10:06:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:06:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozfile 10:06:01 INFO - Running setup.py install for mozhttpd 10:06:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozinfo 10:06:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozInstall 10:06:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozleak 10:06:01 INFO - Running setup.py install for mozlog 10:06:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for moznetwork 10:06:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozprocess 10:06:01 INFO - Running setup.py install for mozprofile 10:06:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:06:01 INFO - Running setup.py install for mozrunner 10:06:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:06:02 INFO - Running setup.py install for mozscreenshot 10:06:02 INFO - Running setup.py install for moztest 10:06:02 INFO - Running setup.py install for mozversion 10:06:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:02 INFO - Cleaning up... 10:06:02 INFO - Return code: 0 10:06:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:06: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')]} 10:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:06:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:02 INFO - Using env: {'DISPLAY': ':0', 10:06:02 INFO - 'HOME': '/home/cltbld', 10:06:02 INFO - 'LANG': 'en_US.UTF-8', 10:06:02 INFO - 'LANGUAGE': 'en_US:en', 10:06:02 INFO - 'LOGNAME': 'cltbld', 10:06:02 INFO - 'MAIL': '/var/mail/cltbld', 10:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:02 INFO - 'MOZ_NO_REMOTE': '1', 10:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:02 INFO - 'NO_EM_RESTART': '1', 10:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:02 INFO - 'SHELL': '/bin/bash', 10:06:02 INFO - 'SHLVL': '1', 10:06:02 INFO - 'TERM': 'linux', 10:06:02 INFO - 'TMOUT': '86400', 10:06:02 INFO - 'USER': 'cltbld', 10:06:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:02 INFO - '_': '/tools/buildbot/bin/python'} 10:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:06:02 INFO - Running setup.py (path:/tmp/pip-q51C1C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:06:02 INFO - Running setup.py (path:/tmp/pip-6tb2XN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:06:02 INFO - Running setup.py (path:/tmp/pip-C4lv_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:06:02 INFO - Running setup.py (path:/tmp/pip-IPveBM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:06:02 INFO - Running setup.py (path:/tmp/pip-zId1No-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:06:02 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)) 10:06:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:06:02 INFO - Running setup.py (path:/tmp/pip-B4NNFM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:06:03 INFO - Running setup.py (path:/tmp/pip-oPmSXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:06:03 INFO - Running setup.py (path:/tmp/pip-uUXAx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:06:03 INFO - Running setup.py (path:/tmp/pip-YBxGvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:03 INFO - Running setup.py (path:/tmp/pip-p28b3s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:03 INFO - Running setup.py (path:/tmp/pip-lLHvbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:03 INFO - Running setup.py (path:/tmp/pip-ehdIl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:03 INFO - Running setup.py (path:/tmp/pip-h6xV1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:03 INFO - Running setup.py (path:/tmp/pip-9Mq_B1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:03 INFO - Running setup.py (path:/tmp/pip-3CY5IV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:03 INFO - Running setup.py (path:/tmp/pip-94bxf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:06:03 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)) 10:06:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:03 INFO - Running setup.py (path:/tmp/pip-JVmIS1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:06:03 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)) 10:06:03 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)) 10:06:03 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)) 10:06:03 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)) 10:06:03 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)) 10:06:03 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)) 10:06:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:05 INFO - Downloading blessings-1.6.tar.gz 10:06:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:05 INFO - Installing collected packages: blessings 10:06:05 INFO - Running setup.py install for blessings 10:06:05 INFO - Successfully installed blessings 10:06:05 INFO - Cleaning up... 10:06:05 INFO - Return code: 0 10:06:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:06:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:06:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:06:06 INFO - Reading from file tmpfile_stdout 10:06:06 INFO - Current package versions: 10:06:06 INFO - argparse == 1.2.1 10:06:06 INFO - blessings == 1.6 10:06:06 INFO - blobuploader == 1.2.4 10:06:06 INFO - docopt == 0.6.1 10:06:06 INFO - manifestparser == 1.1 10:06:06 INFO - mozInstall == 1.12 10:06:06 INFO - mozcrash == 0.16 10:06:06 INFO - mozdebug == 0.1 10:06:06 INFO - mozdevice == 0.47 10:06:06 INFO - mozfile == 1.2 10:06:06 INFO - mozhttpd == 0.7 10:06:06 INFO - mozinfo == 0.9 10:06:06 INFO - mozleak == 0.1 10:06:06 INFO - mozlog == 3.1 10:06:06 INFO - moznetwork == 0.27 10:06:06 INFO - mozprocess == 0.22 10:06:06 INFO - mozprofile == 0.27 10:06:06 INFO - mozrunner == 6.11 10:06:06 INFO - mozscreenshot == 0.1 10:06:06 INFO - mozsystemmonitor == 0.0 10:06:06 INFO - moztest == 0.7 10:06:06 INFO - mozversion == 1.4 10:06:06 INFO - psutil == 3.1.1 10:06:06 INFO - requests == 1.2.3 10:06:06 INFO - wsgiref == 0.1.2 10:06:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:06:06 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')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:06:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:06:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 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)) 10:06:06 INFO - Cleaning up... 10:06:06 INFO - Return code: 0 10:06:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:06:06 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')]} 10:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 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')]} 10:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:06:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:06:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:06:06 INFO - Using env: {'DISPLAY': ':0', 10:06:06 INFO - 'HOME': '/home/cltbld', 10:06:06 INFO - 'LANG': 'en_US.UTF-8', 10:06:06 INFO - 'LANGUAGE': 'en_US:en', 10:06:06 INFO - 'LOGNAME': 'cltbld', 10:06:06 INFO - 'MAIL': '/var/mail/cltbld', 10:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:06 INFO - 'MOZ_NO_REMOTE': '1', 10:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:06 INFO - 'NO_EM_RESTART': '1', 10:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:06 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:06 INFO - 'SHELL': '/bin/bash', 10:06:06 INFO - 'SHLVL': '1', 10:06:06 INFO - 'TERM': 'linux', 10:06:06 INFO - 'TMOUT': '86400', 10:06:06 INFO - 'USER': 'cltbld', 10:06:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:06 INFO - '_': '/tools/buildbot/bin/python'} 10:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:06 INFO - Downloading/unpacking jsonschema 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:06 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 10:06:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:08 INFO - Downloading/unpacking functools32 (from jsonschema) 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 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 10:06:08 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:08 INFO - warning: no files found matching '*.txt' 10:06:08 INFO - no previously-included directories found matching 'build' 10:06:08 INFO - no previously-included directories found matching 'dist' 10:06:08 INFO - no previously-included directories found matching '.git*' 10:06:08 INFO - Installing collected packages: jsonschema, functools32 10:06:08 INFO - Running setup.py install for functools32 10:06:08 INFO - warning: no files found matching '*.txt' 10:06:08 INFO - no previously-included directories found matching 'build' 10:06:08 INFO - no previously-included directories found matching 'dist' 10:06:08 INFO - no previously-included directories found matching '.git*' 10:06:08 INFO - Successfully installed jsonschema functools32 10:06:08 INFO - Cleaning up... 10:06:08 INFO - Return code: 0 10:06:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:06: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')]} 10:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f5635ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', '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 10:06:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:06:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:06:08 INFO - Using env: {'DISPLAY': ':0', 10:06:08 INFO - 'HOME': '/home/cltbld', 10:06:08 INFO - 'LANG': 'en_US.UTF-8', 10:06:08 INFO - 'LANGUAGE': 'en_US:en', 10:06:08 INFO - 'LOGNAME': 'cltbld', 10:06:08 INFO - 'MAIL': '/var/mail/cltbld', 10:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:08 INFO - 'MOZ_NO_REMOTE': '1', 10:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:08 INFO - 'NO_EM_RESTART': '1', 10:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:08 INFO - 'SHELL': '/bin/bash', 10:06:08 INFO - 'SHLVL': '1', 10:06:08 INFO - 'TERM': 'linux', 10:06:08 INFO - 'TMOUT': '86400', 10:06:08 INFO - 'USER': 'cltbld', 10:06:08 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:08 INFO - '_': '/tools/buildbot/bin/python'} 10:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:09 INFO - Downloading/unpacking flake8 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:06:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:06:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:06:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:11 INFO - no previously-included directories found matching 'docs/_build' 10:06:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:06:11 INFO - Running setup.py install for pep8 10:06:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:06:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:06:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:06:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:06:11 INFO - no previously-included directories found matching 'docs/_build' 10:06:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:06:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:06:11 INFO - Cleaning up... 10:06:11 INFO - Return code: 0 10:06:11 INFO - Running post-action listener: _resource_record_post_action 10:06:11 INFO - Running post-action listener: _start_resource_monitoring 10:06:11 INFO - Starting resource monitoring. 10:06:11 INFO - ##### 10:06:11 INFO - ##### Running install step. 10:06:11 INFO - ##### 10:06:11 INFO - Running pre-action listener: _resource_record_pre_action 10:06:11 INFO - Running main action method: install 10:06:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:06:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:06:12 INFO - Reading from file tmpfile_stdout 10:06:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:06:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:06:12 INFO - Reading from file tmpfile_stdout 10:06:12 INFO - Output received: 10:06:12 INFO - Usage: mozinstall [options] installer 10:06:12 INFO - Options: 10:06:12 INFO - -h, --help show this help message and exit 10:06:12 INFO - -d DEST, --destination=DEST 10:06:12 INFO - Directory to install application into. [default: 10:06:12 INFO - "/builds/slave/test-pgo"] 10:06:12 INFO - --app=APP Application being installed. [default: firefox] 10:06:12 INFO - mkdir: /builds/slave/test-pgo/build/application 10:06:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:06:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:06:26 INFO - Reading from file tmpfile_stdout 10:06:26 INFO - Output received: 10:06:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:06:26 INFO - Running post-action listener: _resource_record_post_action 10:06:26 INFO - ##### 10:06:26 INFO - ##### Running run-tests step. 10:06:26 INFO - ##### 10:06:26 INFO - Running pre-action listener: _resource_record_pre_action 10:06:26 INFO - Running main action method: run_tests 10:06:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:06:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:06:26 INFO - Python 2.7.3 10:06:26 INFO - Return code: 0 10:06:26 INFO - grabbing minidump binary from tooltool 10:06:26 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')]} 10:06:26 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 0x1e66350>, '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 0x1e67250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e676e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:06:26 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 10:06:26 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 10:06:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:27 INFO - Return code: 0 10:06:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:06:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:06:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:06:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:06:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:06:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:06:28 INFO - Return code: 0 10:06:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:06:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 10:06:28 INFO - Using env: {'DISPLAY': ':0', 10:06:28 INFO - 'HOME': '/home/cltbld', 10:06:28 INFO - 'LANG': 'en_US.UTF-8', 10:06:28 INFO - 'LANGUAGE': 'en_US:en', 10:06:28 INFO - 'LOGNAME': 'cltbld', 10:06:28 INFO - 'MAIL': '/var/mail/cltbld', 10:06:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:28 INFO - 'MOZ_NO_REMOTE': '1', 10:06:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:28 INFO - 'NO_EM_RESTART': '1', 10:06:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:06:28 INFO - 'PWD': '/builds/slave/test-pgo', 10:06:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:06:28 INFO - 'SHELL': '/bin/bash', 10:06:28 INFO - 'SHLVL': '1', 10:06:28 INFO - 'TERM': 'linux', 10:06:28 INFO - 'TMOUT': '86400', 10:06:28 INFO - 'USER': 'cltbld', 10:06:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042', 10:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:28 INFO - '_': '/tools/buildbot/bin/python'} 10:06:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 10:06:28 INFO - mozversion INFO | application_buildid: 20160215074422 10:06:28 INFO - mozversion INFO | application_changeset: b46a67b9666b63586ba05ab536b0df465dd859dd 10:06:28 INFO - mozversion INFO | application_display_name: Nightly 10:06:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:28 INFO - mozversion INFO | application_name: Firefox 10:06:28 INFO - mozversion INFO | application_remotingname: firefox 10:06:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:28 INFO - mozversion INFO | application_vendor: Mozilla 10:06:28 INFO - mozversion INFO | application_version: 45.0 10:06:28 INFO - mozversion INFO | platform_buildid: 20160215074422 10:06:28 INFO - mozversion INFO | platform_changeset: b46a67b9666b63586ba05ab536b0df465dd859dd 10:06:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:28 INFO - mozversion INFO | platform_version: 45.0 10:06:28 INFO - 2016-02-15 10:06:28,760 DEBUG : using testdate: 1455559588 10:06:28 INFO - 2016-02-15 10:06:28,760 DEBUG : actual date: 1455559588 10:06:28 INFO - 2016-02-15 10:06:28,769 INFO : starting webserver on 'localhost:38446' 10:06:28 INFO - 2016-02-15 10:06:28,769 INFO : Starting test suite talos-linux64-ix-033 10:06:28 INFO - 2016-02-15 10:06:28,769 INFO : Starting test dromaeo_css 10:06:28 INFO - 2016-02-15 10:06:28,770 DEBUG : operating with platform_type : linux_ 10:06:28 INFO - 2016-02-15 10:06:28,770 INFO : Initialising browser for dromaeo_css test... 10:06:28 INFO - 2016-02-15 10:06:28,784 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp56IgfB/profile http://localhost:38446/getInfo.html 10:06:33 INFO - 2016-02-15 10:06:33,657 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:06:33 INFO - 2016-02-15 10:06:33,657 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:06:33 INFO - 2016-02-15 10:06:33,658 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:06:33 INFO - 2016-02-15 10:06:33,658 DEBUG : BROWSER_OUTPUT: __metrics 10:06:33 INFO - 2016-02-15 10:06:33,908 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:35 INFO - 2016-02-15 10:06:35,409 INFO : Browser initialized. 10:06:35 INFO - 2016-02-15 10:06:35,410 INFO : Running cycle 1/1 for dromaeo_css test... 10:06:35 INFO - 2016-02-15 10:06:35,410 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp56IgfB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:06:47 INFO - 2016-02-15 10:06:47,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 134959104 10:06:47 INFO - 2016-02-15 10:06:47,020 DEBUG : BROWSER_OUTPUT: 10:07:37 INFO - 2016-02-15 10:07:37,860 DEBUG : BROWSER_OUTPUT: 1455559657852 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:09:46 INFO - 2016-02-15 10:09:46,786 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38446/tests/dromaeo/cssquery-ext.html) 10:09:47 INFO - 2016-02-15 10:09:47,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 234000384 10:09:47 INFO - 2016-02-15 10:09:47,795 DEBUG : BROWSER_OUTPUT: 10:12:49 INFO - 2016-02-15 10:12:49,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-ext.html (next: http://localhost:38446/tests/dromaeo/cssquery-jquery.html) 10:12:50 INFO - 2016-02-15 10:12:50,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 211816448 10:12:50 INFO - 2016-02-15 10:12:50,429 DEBUG : BROWSER_OUTPUT: 10:15:52 INFO - 2016-02-15 10:15:52,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38446/tests/dromaeo/cssquery-mootools.html) 10:15:52 INFO - 2016-02-15 10:15:52,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 204103680 10:15:52 INFO - 2016-02-15 10:15:52,757 DEBUG : BROWSER_OUTPUT: 10:18:54 INFO - 2016-02-15 10:18:54,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38446/tests/dromaeo/cssquery-prototype.html) 10:18:55 INFO - 2016-02-15 10:18:55,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 202452992 10:18:55 INFO - 2016-02-15 10:18:55,054 DEBUG : BROWSER_OUTPUT: 10:21:57 INFO - 2016-02-15 10:21:57,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38446/tests/dromaeo/cssquery-yui.html) 10:21:57 INFO - 2016-02-15 10:21:57,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 197234688 10:21:57 INFO - 2016-02-15 10:21:57,984 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/dromaeo/cssquery-yui.html (next: http://localhost:38446/tests/dromaeo/cssquery-dojo.html) 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 215007232 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:00 INFO - 2016-02-15 10:25:00,295 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:00 INFO - 2016-02-15 10:25:00,299 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3313.78460400074;3380.0704806178283;3403.995821232738;3410.13041674373;3427.828608569571;5591.7204139793;5619.4099619539875;5631.07087330591;5651.491365777074;5652;5631.943680563193;5648.491635752782;5654.434556544344;5661.1508273758955;5668.971655141719;5034.949650503485;5075.923861142086;5131.974340128294;5163.1480805667015;5228;5066.594672426197;5082.364704411949;5136.794528218867;5166.940777140677;5186.7925282988635;5142.845714628567;5187.507186817265;5198.870028249286;5206.271122042917;5207.791688332462;5140.306058682105;5155.304033955405;5200.6099542534275;5222.817201397933;5237.188235823453;4959.900801983977;4977.776000080005;5051.711813487574;5067.77195026221;5071.011152825164;5400.513953744182;5439.292891924025;5440.700761458118;5441.1838224266285;5447.346318441812;5820.88358232833;6081.3006504252135;6086.878262434727;6088.634681919099;6094.908576371358;5968.4031596840405;6000.729967151445;6021.277446706424;6045.183900173464;6055.182550355734;5631.493165615114;5644.181593668936;5646.774129034875;5650.971745141289;5672.319321681424;6038.456538911519;6134.969325153345;6139.416755408229;6139.846503837351;6148.200733904564;5850.268716410449;5902.970485147547;5913.704314784243;5914.319853216849;5950.434708702666;6075.301340345917;6085.056816193497;6100.847478812976;6106.236720409949;6111.755529778759;5822.388649191858;5868.67722275279;5913.76344946206;6036.0644100164545;6046.516278697693;5919.970400147971;5956.821295361146;5996.37038110992;6037.78867739627;6047.395260474005;4585.220512512881;4594.333821595917;4607.401037865056;4614.446266448048;4629.699069560468;4061.431399604058;4138.565450627701;4141.52372477169;4144.212599606065;4159.833606655699;5641;5707.34365547959;5707.34365547959;5711.3146422428745;5747.971260143756;6061.878762424727;6099.2985806632805;6101.237345331833;6111.052786818051;6120.051392034242;5600.551955843523;5608.130739735266;5740.13897915316;5753.4821866031425;5787.479126878601;5252;5283.07546179417;5291.470852914755;5293.311869456946;5315.043292207362;6226.377362263828;6258.123862659231;6260.530460215502;6262;6272.937270627235;5839.912401314069;5939.732712027882;6067.453929146398;6141.785037523665;6191.81424557264;6253.749850006131;6271.498280137487;6277.654728989949;6277.905831412441;6293.905591416041;6027.819165425044;6036.547258955684;6039;6047.637141771508;6056.757729690763;5833.241678581757;5932.584719069796;5943.910841337297;6011.609245399035;6130.295016073209;5917.3490915998345;5947.881042379042;5980.312264089685;5999.49004334619;6003.6397816131175;5910.586258962004;5961.463468287875;5977.073553599199;5986.6707331097205;5992.67040312787;5604.131359639263;5719.256496655408;5724.627899186539;5795.1017592273265;5831.067029275296;5932.0508718604815;5964.522838172849;5999.5800293979;6004.219451471456;6010.33886272501;5605.5515558756015;5816.272965879265;5833.212516310244;5839.0949402842625;5845.473907348359 10:25:00 INFO - 2016-02-15 10:25:00,299 DEBUG : BROWSER_OUTPUT: |1;ext.html;583.670226322128;634.5684934244717;643.3470027921658;645.0421124629926;648.8507643242053;32493.51259731103;41182.17635647289;41472.37791433131;41513.37729934046;41550.79224603876;46654.300185497246;47087.29369059458;47136.52863471373;47176.29235561469;47217.291740623834;8102.311303539206;8240.258376746091;9113.0886911309;9284.582193801261;9288.256939444862;10774.676759697222;11018.889811101906;11048.447577621127;11054.226204165672;11066.612668556601;10802.405867677315;10912.127029837595;10919.181061420386;10921.836172457419;10925;8344.123866993968;8531.616077276538;8561.871571926426;10710.46447677617;10888.727781805439;10636.20228482859;10739.087177589914;10808.891911080867;10813.297135686234;10820.72948176294;43086.78456607728;43490.56509434897;43491.34762978558;43565;43630.78184609057;3679.632036796326;3688.704903607705;3788.29916465452;3799.4870692456443;4058.2492238935597;32725;32899.17752056194;33039.50440743391;33387.16532086693;35169.64830351689;3899.493065901443;3912.334903066457;3925.6074392560517;3978.3598007822807;3979.985103798542;294222;297151;297583;298814.50592747115;299022;58776.70611646914;59585.106223406685;74267.62866185742;75337.62331188309;75470;65343;65394.346056539776;65481.345186548475;65544;65662.34337656658;15798.289076991563;15814.288357023732;15827.208639567976;15832.129232892072;15897.761533577006;11455.369954652575;11769.88230117705;11853.703657408461;12065.517379304729;12142.45358958849;21964.231251906105;22563;22622.493513505433;22643;22653.660195097087;8025.759227223192;8355.206255405727;8425.272819072075;8471.237588617054;8476.660933562713;983.3215081593678;1076.56399158341;1117.279354816139;1124.58952482345;1151.6084531259412;28369;28724.569131463046;28848.423031539252;29039.709602904124;29402.411951760845;1075.961696962435;1122.4443900269418;1171.1918776044672;1201.6755476021426;1210.1336230742868;14756.704865902622;14987.250637468083;15496.767548486781;17725;17980.460586182435;408765;408864;410889;411090;411213;58618.706906466046;58708.706456468295;58886.41113588895;59350.70324648349;59565.70217148887;1350.156152404747;1374.2579007336126;1441.988426145542;1443.4154167562153;1451.992740036293;34541.13647158841;34647.307053858276;34761.304773903874;34872.12819679528;35081.82459087688;53791.193132102264;54439.72780136232;54440.45559544354;54522.727386362814;54596.45403545914;317140;318634;318920;319121;320837;35725.46411803773;35797.82101089582;36333.45499817452;36416.81791591025;36427.45358819567;46805.29792053054;46927;47306.29040564325;47751.76124119357;48183;39014.837388219785;39650;39716;40028.19943601053;40282.79858600688;38556.614433855306;39995.80002099971;40238.45303100155;40556;40604.98487537835;38777.61222387853;39168.216635666555;39796.80101599474;39808.40287395749;39855.40216896691;34693;35811.462828057076;35919.46120808242;35977;36262.09344766402;26888.59667105034;27242.863785680944;27246.04638837631;27247.31881702894;27356.042538511058 10:25:00 INFO - 2016-02-15 10:25:00,299 DEBUG : BROWSER_OUTPUT: |2;jquery.html;390.8846890167402;395.8990457433355;397.7673061259162;398.9122393073523;399.18366939608495;15522.844771552282;16977.83022169778;18177.63644727105;18296.542586435346;18307.267709291627;10951.671449856498;11209.775804483905;11324.094072474203;18178.363757268497;18446.44660660179;5094.057599344133;5216.634835561512;5217.973910130444;5218.295530103444;5219.9478005220035;3974.6621537169376;4032.1532478179615;5148.150555158394;5557.305336832896;5719.542436605082;5657.632253903504;5686.658800471985;5687.516561092312;5700.629459085167;5710.114932185497;5535.335759708821;5642.238297829782;5652.152177173436;5654.46282603152;5655.4910058094965;5437.02133615949;5449.945500544984;5452.536534394581;5461.590380721422;5470.452954704498;19986.10062547189;20943.68584471234;21328.360149195392;21374.145034198613;21429;2273.6475846243857;2318.4088057545387;2369.7274813396507;2376.66726658268;2378.9762102378927;9778.706638800848;9950;11005.889941100566;11010.39442830644;14043.22762248076;1952.9902350488157;1962.8724132931313;1986.5728868293386;2001.789812069741;2032.2683833819813;61596.384036159514;61889.38110618926;62395.37604623941;62704;63086.68456657733;10683.519241634145;10971.561137554409;11118;11142.777144457066;11182.161337899528;14533.200673962821;14536.345864436125;14546.472620374709;14559.927200364142;14560.344784484723;7772.805679858049;7790;7825.569593672402;7844.84310313802;7846.097698764601;7456.366208872307;7482.47622666419;7579.317861392501;7820.960895195488;7847.887969928505;4521.886952826206;4562.520935301745;4668.8132474701315;4754.9286760698615;4952.678075925053;1689.133425034388;1944.6013567218686;1978.7526559180103;1994.2521554417094;2001.3595649392346;1011.4133802394593;1027.1525991057408;1093;1129.4635048352131;1153.7692461507731;14832.92583537097;17048.2328295227;17192.27161134501;18083.54791130232;18293.7255941161;964.9179819715263;982.5627595719836;1012.7417508535276;1064.1912146768511;1073.9677809665723;9578.031143780025;9874.21006319507;9901.455419951828;9941.900580994243;9953.402795832273;668893;670798;685955;695905;703750;78392.60803695946;85124.14875851286;86509;87490.56254718686;87498;1183.1008433590532;1193.1826698711411;1213.3144773203112;1213.6844420450745;1215.392303848076;15239;15610.375584976928;15741.527754167393;15813.920930395274;15845.762313565076;32620.673793261765;33255;33795.32409351848;33889.322213556086;34980.30039399147;42656.57343426526;44692;48869.26696099633;50454.49545504498;50458;9638.95180524093;9703.466309353053;9718.805623887623;9798.706038818847;9832.705018849447;11292.15308851823;11359.602413915472;11362.488688008894;11409.543618255177;12453.439595218055;14491.492797752027;14558.4904528341;15006.399744010554;15390;15917.681646366776;14289.42842286297;14490.058146220463;15377.615559611098;15997.1201583914;16710.16449177512;12570.308633025272;15006.324715388053;15122.243887805786;15310.693786124439;16681;9325.026784651327;9599.664011759554;9641.469719165232;9658.613655453984;9735.659251926148;10084.14284785772;11597;15035.248237588296;15048.548543543711;15258.08451492914 10:25:00 INFO - 2016-02-15 10:25:00,300 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1565.4755656854952;1773.8314860088292;1799.0421073637995;1853.2123847364876;1867.9533011674707;8001.679932802688;8238.588070596476;8261.628226729797;8261.876071858927;8261.958690206548;7296.270372962715;7429.702811887531;7849.136594974562;8093.595320233994;8171.591420428985;2376.3583832365293;2396.7123945126523;2421.237310247275;2421.2978236311446;2422.067504010951;2045.0388317490756;2413.505231427553;2447.021191523396;2455.0793452455327;2461.089396923141;2059.969100463494;2357.2221167014845;2411.03558576569;2413.4690368119072;2414.8309618326725;2348.084247143624;2385.522895420923;2388.3073908566494;2392.091005417939;2398.364433425135;2328.860268383902;2355.3405046586813;2360.917367892133;2381.452265978817;2433.7566243375522;8145.51126932386;8222.917770822274;8241.134680858544;8244.134365891556;8244.876326855101;4902.093112774148;4941.308216849644;4988.67573607718;4999.12515309823;4999.32509111269;3138.5606015157896;3146.921326966821;3207.134073800061;3243.497257925025;3278.999905028989;1023.918086553074;1024.9289492480302;1040.5057597641135;1053.1153830782102;1066.2855886556026;11390.316581005083;11412.942935285271;11421.543138274543;11423.314601123959;11438.771224575461;4323.567643235651;4329.567043295709;4382.342648602735;4410.095930334273;4414.09511050234;9764.707058788248;9793.804123917482;9801.607935682636;9811.607535698635;9819.36174148678;4993.350864387607;4993.6005119590345;4994.101061808837;4997.0505603935135;5003.949960500421;4480.059187570581;4493.932591011137;4519.231730605805;4531.456225252925;4531.592156705847;3931.095847954929;3974.16542526067;3997.380406037069;4000.159966407029;4053.6351728344002;1128.6670432222513;1206.7284860906225;1236.5486597392066;1262.1921969939247;1265.8987281017496;1101.801675698382;1130.909527237819;1140.1391949078393;1377.6211541826078;1460.9919155782477;7834.921650783534;7864.41016923733;7922.841543169105;7946.6424010919645;7968.482048666818;1176.3177357132843;1187.1689817128045;1194.75507520958;1211.2429731417865;1224.7489264700714;6108.664023478751;6164.137020817089;6190;6197.163382943335;6204.968975155095;9441.669541566149;9495.90504094964;9553.187979021723;9621.374610650286;9633.855492167622;9446.149846513847;9490.810183796286;9504.47725375111;9627.759306017406;9650.855237171449;7783.182765809622;7797.80505487356;7838.921610783933;7888.329491993245;7897.17079706634;7820;7859.567723775019;7913.327367173854;7933.206679332021;7961.044674639081;8788.296936244957;8835.11648835137;8948.149925757043;8998.59506322204;9069.591868365807;9143.862842057508;9242.214411775074;9248.815023699623;9249.583768730557;9261.305402094735;6908.412784913137;6984.161900571964;6987.1266091738535;6998.16022077354;7003.124609423822;7565.205653406313;7578.317951384402;7596.924030759843;7598.0502437195355;7645.273698998586;6711.4966377520905;7038.507304488637;7134.750283740044;7155.356017958408;7254.129504459287;6541.574797638138;7363.963180184065;7417.443691723034;7516.549007059594;7573.9242607573215;7354.043974283309;7384.224656411215;7385.335319821242;7395.075615548057;7400.333969942731;6486.4486518646445;6520.576162549419;6520.9347906520325;6536.281009088902;6541.443977261986;6590.604563726191;6735.49483788708;6742.494312926452;6750;6782.593044417351 10:25:00 INFO - 2016-02-15 10:25:00,300 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.513343485533;361.81728227245253;367.9025058359535;368.8432416223105;372.9403295472724;6045.455908968192;6089.78685745999;6130.632162070279;6151.138840562314;6151.784687535937;5775.249217601706;5847.356790753014;5916.378780228068;6010.819675409744;6034.366391528881;4691.179043667362;4693;4721.881952951187;4726.90546189076;4737.407824021997;4451.243288640939;4723.3859598252175;4726.763661816913;4730.385049943519;4731.810727570893;4477.753723545204;4551.886202844938;4685.976570117145;4687.109449204657;4692.41344831896;4638.814447422099;4655.650826188049;4658.114958157973;4664.463586687541;4674.462436819776;4164.167166566668;4166.66666666666;4171.478565179353;4172.603602657743;4179;5626.578006649518;5697.743601537941;5740.454656807597;5744.454276843693;5750.482456578886;5419.160030195326;5431.456854314576;5437.265969094161;5438.048341540254;5439.428859969686;6416.358364163593;6430.517711171634;6434.517411194179;6439.8068057958335;6441.291457939623;4538.228501154778;4539.432570928634;4542.841000564998;4544.363789069533;4555.362249285103;6536.05227242052;6578.309277525838;6658.733650653968;6661.333866613349;6673.299303573152;4648.465426475998;4654.557817007379;4656.813727450932;4657.347971284023;4661.184292748823;4715.104130215248;4718.504557021532;4724.622030237572;4725.787339569728;4726.692764970266;5411.5129638331955;5422.6475279106735;5423.810166644227;5424.321959755031;5424.83725488236;6268.968655156695;6459.806205813833;6470.4823614110755;6474.643894585749;6478.676066196671;1629.144699033017;1629.5518732348698;1630.168614006865;1630.5515983104503;1631.9755203671955;1103.315944114654;1139.6922830835629;1144.3191301175787;1157.924734892246;1162.0645380468634;6257;6259.749610015549;6267.62394256346;6267.96866015667;6271.216097987752;6460.3862633049785;6608.96695516529;6635.568688035262;6638.4689224861895;6641;6176.3514830943;6207.224096987877;6319.968400158062;6322.747090116344;6328.177336946167;3573.3925232710503;3602;3604.387254166798;3604.747667663291;3611.4221724524477;6687;6863.073485079451;6867.141607299088;6868.313168683192;6875.621840798804;6792.864142717118;6823.55646882951;6850.828729281808;6861.725530978705;6872.828179295558;6845.623490707959;6866.931330686629;6870.3473170048765;6876.587404755631;6877.243503214642;6542.574732642363;6656.500762442933;6696.029075784081;6704.832379190364;6719.563228390139;6596.30738772422;6635.336466353519;6638.17022872141;6655.367740064686;6659.2008958925235;6892.517523773287;6895.724171033103;6899.48253880971;6901.137357830271;6904.620245886525;4580.358749774968;4616.884577885579;4673.929891051569;4680.134175177467;4682.15721170179;6674.833129171615;6704.4301234395625;6725;6726.39462448382;6729.596224226562;6507.479401647952;6511.153550038654;6513.54405191632;6519.217693876765;6522.510811689048;6439.517036222208;6491.188601424822;6527.086207930798;6530.771423000172;6532.444742196966;6401.487880969418;6403.039544068427;6409.9679501602195;6410.647414392253;6414.711337989895;6499.805005849832;6534.705938232886;6537.248216454978;6540.542162048611;6546.869062618816;6225.470834979077;6339.207599050119;6340.112384266298;6349.0476428536085;6352.491800655844 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: |5;yui.html;789.8380831929454;888;899.9820003599932;904.4934836491569;924.9260059195263;12580.182288151263;13248.867511324885;13291.069625126222;13331.466741330336;13683;12864.485420583165;13169.275689837055;13806.30968451576;13833.239171845544;13863.792043119362;724.0189543169009;730.3025610541946;863.2662237098464;881;886.366248132585;872.4852337121097;876.3558784293539;882.0782282514788;882.5190271302156;882.5587206396801;923.2844545477275;930.5905401623298;931.3759780946782;931.4690626342987;931.8741969834088;761.402299195132;768.1435199752264;916.225789208118;934.7943452440452;937.1191080384485;687.9690413931385;693.0332186599716;694.2883544367014;694.447913908444;695.151914664109;12829.358532073453;12841.807372889414;12846.229226246362;12878.87121128786;12909;11582.826257606142;11967.880321196764;12023.879761202363;12407.627771166879;12814.35928203586;10405.323653962469;10739.731506712316;10801.729956751065;10820.404877731722;10854.511546980404;3736.3461394255896;3794.7343685941996;3806.2197249563774;3813.656770890633;3819.102510909934;45349.77325113386;46222;47197.292040619075;47655.76172119117;47700.045999079826;10286.691399258034;10397;10418.374897506174;10488.423136727553;10597.311174773615;17508.387206447715;17509.12454377276;17554.91222543879;17563.912180439016;17580.208890599955;6950.54821436605;7058.823529411806;7295;7635.732749353857;7821.374290056782;4117.3618089196225;4277.636400905895;4435.401220835211;4465.129299786576;4508.368828364031;3176.4123637127204;3203.9038828835173;3206.3106432117206;3208.51872219169;3208.69517395847;603.8912995660735;609.2688773471851;611.3000614296606;619.2166908860295;641.377863472431;579.2469789273927;699.5103427600599;704.1479809430544;715.377621469325;719.9712011519481;8423.536705481258;8648.913510864812;8777.648894044167;8785.780355491035;8872.423292485968;532.6165161084014;573.8479302984713;717.6913927011435;722.5159143373952;741.8108382362464;3965.266425711253;4039.9192016159514;4113.85601503946;4121.670266378743;4137.834486620502;61570.69214653898;62531.37468625347;62630.37369626245;62679;62734.43163920938;49262.50737492651;49932.25101623406;50216.233782466465;51794;55846.441535584934;46990.76504617455;49702.25446618304;50209.497905020486;50428.49571504238;50495.24257136146;8485.57572121379;8553.101924297858;8597.226249637313;9037.412568183046;9151.222146117654;36152.096197595274;37323.62676373201;37601.05997349979;37728.62271377251;37925.431118533794;49000;49072;49105.263421047996;49130.75434622947;49924.75037624789;11325.433728313716;11734.589289374831;11986.460609272777;12032.699182520508;12079.27524348542;11926.463309151282;12050.578229761917;12066.698332541757;12116.575919842764;12833;11599.130065245308;11968.581099661471;11982.520699172284;11995.880041199825;12028.699282518008;11407.543698251977;11600.535978560763;11627.069834413058;11718.414079296172;11957.641270761891;10720.73198170052;10768.2147485711;11113.055390291916;11156.163287753614;11194.496247669038;9466.384684995453;9475.33672642936;9493.620255189715;9811.509424528887;9829.508524573599;9580.730598171118;9581.185599224144;9628.9037109628;9821.263405244492;10096.596136154472 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,753 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: __startTimestamp1455560700294__endTimestamp 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,302 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:00 INFO - 2016-02-15 10:25:00,303 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:25:00 INFO - 2016-02-15 10:25:00,303 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,303 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5607.82 Median:5822.39 stddev:624.01 (10.7%) stddev-sans-first:599.41 10:25:00 INFO - 2016-02-15 10:25:00,304 DEBUG : BROWSER_OUTPUT: Values: 3313.8 3380.1 3404.0 3410.1 3427.8 5591.7 5619.4 5631.1 5651.5 5652.0 5631.9 5648.5 5654.4 5661.2 5669.0 5034.9 5075.9 5132.0 5163.1 5228.0 5066.6 5082.4 5136.8 5166.9 5186.8 5142.8 5187.5 5198.9 5206.3 5207.8 5140.3 5155.3 5200.6 5222.8 5237.2 4959.9 4977.8 5051.7 5067.8 5071.0 5400.5 5439.3 5440.7 5441.2 5447.3 5820.9 6081.3 6086.9 6088.6 6094.9 5968.4 6000.7 6021.3 6045.2 6055.2 5631.5 5644.2 5646.8 5651.0 5672.3 6038.5 6135.0 6139.4 6139.8 6148.2 5850.3 5903.0 5913.7 5914.3 5950.4 6075.3 6085.1 6100.8 6106.2 6111.8 5822.4 5868.7 5913.8 6036.1 6046.5 5920.0 5956.8 5996.4 6037.8 6047.4 4585.2 4594.3 4607.4 4614.4 4629.7 4061.4 4138.6 4141.5 4144.2 4159.8 5641.0 5707.3 5707.3 5711.3 5748.0 6061.9 6099.3 6101.2 6111.1 6120.1 5600.6 5608.1 5740.1 5753.5 5787.5 5252.0 5283.1 5291.5 5293.3 5315.0 6226.4 6258.1 6260.5 6262.0 6272.9 5839.9 5939.7 6067.5 6141.8 6191.8 6253.7 6271.5 6277.7 6277.9 6293.9 6027.8 6036.5 6039.0 6047.6 6056.8 5833.2 5932.6 5943.9 6011.6 6130.3 5917.3 5947.9 5980.3 5999.5 6003.6 5910.6 5961.5 5977.1 5986.7 5992.7 5604.1 5719.3 5724.6 5795.1 5831.1 5932.1 5964.5 5999.6 6004.2 6010.3 5605.6 5816.3 5833.2 5839.1 5845.5 10:25:00 INFO - 2016-02-15 10:25:00,304 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,305 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52904.26 Median:36422.14 stddev:90632.79 (248.8%) stddev-sans-first:90801.90 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: Values: 583.7 634.6 643.3 645.0 648.9 32493.5 41182.2 41472.4 41513.4 41550.8 46654.3 47087.3 47136.5 47176.3 47217.3 8102.3 8240.3 9113.1 9284.6 9288.3 10774.7 11018.9 11048.4 11054.2 11066.6 10802.4 10912.1 10919.2 10921.8 10925.0 8344.1 8531.6 8561.9 10710.5 10888.7 10636.2 10739.1 10808.9 10813.3 10820.7 43086.8 43490.6 43491.3 43565.0 43630.8 3679.6 3688.7 3788.3 3799.5 4058.2 32725.0 32899.2 33039.5 33387.2 35169.6 3899.5 3912.3 3925.6 3978.4 3980.0 294222.0 297151.0 297583.0 298814.5 299022.0 58776.7 59585.1 74267.6 75337.6 75470.0 65343.0 65394.3 65481.3 65544.0 65662.3 15798.3 15814.3 15827.2 15832.1 15897.8 11455.4 11769.9 11853.7 12065.5 12142.5 21964.2 22563.0 22622.5 22643.0 22653.7 8025.8 8355.2 8425.3 8471.2 8476.7 983.3 1076.6 1117.3 1124.6 1151.6 28369.0 28724.6 28848.4 29039.7 29402.4 1076.0 1122.4 1171.2 1201.7 1210.1 14756.7 14987.3 15496.8 17725.0 17980.5 408765.0 408864.0 410889.0 411090.0 411213.0 58618.7 58708.7 58886.4 59350.7 59565.7 1350.2 1374.3 1442.0 1443.4 1452.0 34541.1 34647.3 34761.3 34872.1 35081.8 53791.2 54439.7 54440.5 54522.7 54596.5 317140.0 318634.0 318920.0 319121.0 320837.0 35725.5 35797.8 36333.5 36416.8 36427.5 46805.3 46927.0 47306.3 47751.8 48183.0 39014.8 39650.0 39716.0 40028.2 40282.8 38556.6 39995.8 40238.5 40556.0 40605.0 38777.6 39168.2 39796.8 39808.4 39855.4 34693.0 35811.5 35919.5 35977.0 36262.1 26888.6 27242.9 27246.0 27247.3 27356.0 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33110.63 Median:17499.83 stddev:111877.90 (639.3%) stddev-sans-first:112164.77 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: Values: 390.9 395.9 397.8 398.9 399.2 15522.8 16977.8 18177.6 18296.5 18307.3 10951.7 11209.8 11324.1 18178.4 18446.4 5094.1 5216.6 5218.0 5218.3 5219.9 3974.7 4032.2 5148.2 5557.3 5719.5 5657.6 5686.7 5687.5 5700.6 5710.1 5535.3 5642.2 5652.2 5654.5 5655.5 5437.0 5449.9 5452.5 5461.6 5470.5 19986.1 20943.7 21328.4 21374.1 21429.0 2273.6 2318.4 2369.7 2376.7 2379.0 9778.7 9950.0 11005.9 11010.4 14043.2 1953.0 1962.9 1986.6 2001.8 2032.3 61596.4 61889.4 62395.4 62704.0 63086.7 10683.5 10971.6 11118.0 11142.8 11182.2 14533.2 14536.3 14546.5 14559.9 14560.3 7772.8 7790.0 7825.6 7844.8 7846.1 7456.4 7482.5 7579.3 7821.0 7847.9 4521.9 4562.5 4668.8 4754.9 4952.7 1689.1 1944.6 1978.8 1994.3 2001.4 1011.4 1027.2 1093.0 1129.5 1153.8 14832.9 17048.2 17192.3 18083.5 18293.7 964.9 982.6 1012.7 1064.2 1074.0 9578.0 9874.2 9901.5 9941.9 9953.4 668893.0 670798.0 685955.0 695905.0 703750.0 78392.6 85124.1 86509.0 87490.6 87498.0 1183.1 1193.2 1213.3 1213.7 1215.4 15239.0 15610.4 15741.5 15813.9 15845.8 32620.7 33255.0 33795.3 33889.3 34980.3 42656.6 44692.0 48869.3 50454.5 50458.0 9639.0 9703.5 9718.8 9798.7 9832.7 11292.2 11359.6 11362.5 11409.5 12453.4 14491.5 14558.5 15006.4 15390.0 15917.7 14289.4 14490.1 15377.6 15997.1 16710.2 12570.3 15006.3 15122.2 15310.7 16681.0 9325.0 9599.7 9641.5 9658.6 9735.7 10084.1 11597.0 15035.2 15048.5 15258.1 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,306 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5733.06 Median:6503.51 stddev:2961.52 (45.5%) stddev-sans-first:2953.26 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: Values: 1565.5 1773.8 1799.0 1853.2 1868.0 8001.7 8238.6 8261.6 8261.9 8262.0 7296.3 7429.7 7849.1 8093.6 8171.6 2376.4 2396.7 2421.2 2421.3 2422.1 2045.0 2413.5 2447.0 2455.1 2461.1 2060.0 2357.2 2411.0 2413.5 2414.8 2348.1 2385.5 2388.3 2392.1 2398.4 2328.9 2355.3 2360.9 2381.5 2433.8 8145.5 8222.9 8241.1 8244.1 8244.9 4902.1 4941.3 4988.7 4999.1 4999.3 3138.6 3146.9 3207.1 3243.5 3279.0 1023.9 1024.9 1040.5 1053.1 1066.3 11390.3 11412.9 11421.5 11423.3 11438.8 4323.6 4329.6 4382.3 4410.1 4414.1 9764.7 9793.8 9801.6 9811.6 9819.4 4993.4 4993.6 4994.1 4997.1 5003.9 4480.1 4493.9 4519.2 4531.5 4531.6 3931.1 3974.2 3997.4 4000.2 4053.6 1128.7 1206.7 1236.5 1262.2 1265.9 1101.8 1130.9 1140.1 1377.6 1461.0 7834.9 7864.4 7922.8 7946.6 7968.5 1176.3 1187.2 1194.8 1211.2 1224.7 6108.7 6164.1 6190.0 6197.2 6205.0 9441.7 9495.9 9553.2 9621.4 9633.9 9446.1 9490.8 9504.5 9627.8 9650.9 7783.2 7797.8 7838.9 7888.3 7897.2 7820.0 7859.6 7913.3 7933.2 7961.0 8788.3 8835.1 8948.1 8998.6 9069.6 9143.9 9242.2 9248.8 9249.6 9261.3 6908.4 6984.2 6987.1 6998.2 7003.1 7565.2 7578.3 7596.9 7598.1 7645.3 6711.5 7038.5 7134.8 7155.4 7254.1 6541.6 7364.0 7417.4 7516.5 7573.9 7354.0 7384.2 7385.3 7395.1 7400.3 6486.4 6520.6 6520.9 6536.3 6541.4 6590.6 6735.5 6742.5 6750.0 6782.6 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5418.96 Median:6191.79 stddev:1615.41 (26.1%) stddev-sans-first:1574.35 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: Values: 341.5 361.8 367.9 368.8 372.9 6045.5 6089.8 6130.6 6151.1 6151.8 5775.2 5847.4 5916.4 6010.8 6034.4 4691.2 4693.0 4721.9 4726.9 4737.4 4451.2 4723.4 4726.8 4730.4 4731.8 4477.8 4551.9 4686.0 4687.1 4692.4 4638.8 4655.7 4658.1 4664.5 4674.5 4164.2 4166.7 4171.5 4172.6 4179.0 5626.6 5697.7 5740.5 5744.5 5750.5 5419.2 5431.5 5437.3 5438.0 5439.4 6416.4 6430.5 6434.5 6439.8 6441.3 4538.2 4539.4 4542.8 4544.4 4555.4 6536.1 6578.3 6658.7 6661.3 6673.3 4648.5 4654.6 4656.8 4657.3 4661.2 4715.1 4718.5 4724.6 4725.8 4726.7 5411.5 5422.6 5423.8 5424.3 5424.8 6269.0 6459.8 6470.5 6474.6 6478.7 1629.1 1629.6 1630.2 1630.6 1632.0 1103.3 1139.7 1144.3 1157.9 1162.1 6257.0 6259.7 6267.6 6268.0 6271.2 6460.4 6609.0 6635.6 6638.5 6641.0 6176.4 6207.2 6320.0 6322.7 6328.2 3573.4 3602.0 3604.4 3604.7 3611.4 6687.0 6863.1 6867.1 6868.3 6875.6 6792.9 6823.6 6850.8 6861.7 6872.8 6845.6 6866.9 6870.3 6876.6 6877.2 6542.6 6656.5 6696.0 6704.8 6719.6 6596.3 6635.3 6638.2 6655.4 6659.2 6892.5 6895.7 6899.5 6901.1 6904.6 4580.4 4616.9 4673.9 4680.1 4682.2 6674.8 6704.4 6725.0 6726.4 6729.6 6507.5 6511.2 6513.5 6519.2 6522.5 6439.5 6491.2 6527.1 6530.8 6532.4 6401.5 6403.0 6410.0 6410.6 6414.7 6499.8 6534.7 6537.2 6540.5 6546.9 6225.5 6339.2 6340.1 6349.0 6352.5 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,307 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14236.38 Median:47677.90 stddev:16774.16 (35.2%) stddev-sans-first:16790.82 10:25:00 INFO - 2016-02-15 10:25:00,308 DEBUG : BROWSER_OUTPUT: Values: 789.8 888.0 900.0 904.5 924.9 12580.2 13248.9 13291.1 13331.5 13683.0 12864.5 13169.3 13806.3 13833.2 13863.8 724.0 730.3 863.3 881.0 886.4 872.5 876.4 882.1 882.5 882.6 923.3 930.6 931.4 931.5 931.9 761.4 768.1 916.2 934.8 937.1 688.0 693.0 694.3 694.4 695.2 12829.4 12841.8 12846.2 12878.9 12909.0 11582.8 11967.9 12023.9 12407.6 12814.4 10405.3 10739.7 10801.7 10820.4 10854.5 3736.3 3794.7 3806.2 3813.7 3819.1 45349.8 46222.0 47197.3 47655.8 47700.0 10286.7 10397.0 10418.4 10488.4 10597.3 17508.4 17509.1 17554.9 17563.9 17580.2 6950.5 7058.8 7295.0 7635.7 7821.4 4117.4 4277.6 4435.4 4465.1 4508.4 3176.4 3203.9 3206.3 3208.5 3208.7 603.9 609.3 611.3 619.2 641.4 579.2 699.5 704.1 715.4 720.0 8423.5 8648.9 8777.6 8785.8 8872.4 532.6 573.8 717.7 722.5 741.8 3965.3 4039.9 4113.9 4121.7 4137.8 61570.7 62531.4 62630.4 62679.0 62734.4 49262.5 49932.3 50216.2 51794.0 55846.4 46990.8 49702.3 50209.5 50428.5 50495.2 8485.6 8553.1 8597.2 9037.4 9151.2 36152.1 37323.6 37601.1 37728.6 37925.4 49000.0 49072.0 49105.3 49130.8 49924.8 11325.4 11734.6 11986.5 12032.7 12079.3 11926.5 12050.6 12066.7 12116.6 12833.0 11599.1 11968.6 11982.5 11995.9 12028.7 11407.5 11600.5 11627.1 11718.4 11957.6 10720.7 10768.2 11113.1 11156.2 11194.5 9466.4 9475.3 9493.6 9811.5 9829.5 9580.7 9581.2 9628.9 9821.3 10096.6 10:25:00 INFO - 2016-02-15 10:25:00,309 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:00 INFO - 2016-02-15 10:25:00,309 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-15 10:25:00,937 INFO : Browser exited with error code: 0 10:25:00 INFO - 2016-02-15 10:25:00,953 INFO : Completed test dromaeo_css (00:18:32) 10:25:00 INFO - 2016-02-15 10:25:00,953 INFO : Starting test kraken 10:25:00 INFO - 2016-02-15 10:25:00,953 DEBUG : operating with platform_type : linux_ 10:25:00 INFO - 2016-02-15 10:25:00,953 INFO : Initialising browser for kraken test... 10:25:00 INFO - 2016-02-15 10:25:00,960 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ7rOEk/profile http://localhost:38446/getInfo.html 10:25:05 INFO - 2016-02-15 10:25:05,078 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:25:05 INFO - 2016-02-15 10:25:05,078 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:25:05 INFO - 2016-02-15 10:25:05,078 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:25:05 INFO - 2016-02-15 10:25:05,078 DEBUG : BROWSER_OUTPUT: __metrics 10:25:05 INFO - 2016-02-15 10:25:05,288 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:06 INFO - 2016-02-15 10:25:06,693 INFO : Browser initialized. 10:25:06 INFO - 2016-02-15 10:25:06,694 INFO : Running cycle 1/1 for kraken test... 10:25:06 INFO - 2016-02-15 10:25:06,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ7rOEk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:25:18 INFO - 2016-02-15 10:25:18,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 133074944 10:25:18 INFO - 2016-02-15 10:25:18,376 DEBUG : BROWSER_OUTPUT: 10:25:20 INFO - 2016-02-15 10:25:20,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38446/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:21 INFO - 2016-02-15 10:25:21,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 166203392 10:25:21 INFO - 2016-02-15 10:25:21,399 DEBUG : BROWSER_OUTPUT: 10:25:23 INFO - 2016-02-15 10:25:23,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38446/tests/kraken/driver.html?testName=audio-dft) 10:25:24 INFO - 2016-02-15 10:25:24,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 162332672 10:25:24 INFO - 2016-02-15 10:25:24,515 DEBUG : BROWSER_OUTPUT: 10:25:27 INFO - 2016-02-15 10:25:27,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38446/tests/kraken/driver.html?testName=audio-fft) 10:25:27 INFO - 2016-02-15 10:25:27,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 160301056 10:25:27 INFO - 2016-02-15 10:25:27,855 DEBUG : BROWSER_OUTPUT: 10:25:29 INFO - 2016-02-15 10:25:29,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38446/tests/kraken/driver.html?testName=audio-oscillator) 10:25:30 INFO - 2016-02-15 10:25:30,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 158949376 10:25:30 INFO - 2016-02-15 10:25:30,427 DEBUG : BROWSER_OUTPUT: 10:25:32 INFO - 2016-02-15 10:25:32,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:33 INFO - 2016-02-15 10:25:33,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 159895552 10:25:33 INFO - 2016-02-15 10:25:33,143 DEBUG : BROWSER_OUTPUT: 10:25:35 INFO - 2016-02-15 10:25:35,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38446/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:36 INFO - 2016-02-15 10:25:36,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 160124928 10:25:36 INFO - 2016-02-15 10:25:36,557 DEBUG : BROWSER_OUTPUT: 10:25:39 INFO - 2016-02-15 10:25:39,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38446/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:40 INFO - 2016-02-15 10:25:40,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 161378304 10:25:40 INFO - 2016-02-15 10:25:40,492 DEBUG : BROWSER_OUTPUT: 10:25:43 INFO - 2016-02-15 10:25:43,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38446/tests/kraken/driver.html?testName=json-parse-financial) 10:25:43 INFO - 2016-02-15 10:25:43,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 159711232 10:25:43 INFO - 2016-02-15 10:25:43,745 DEBUG : BROWSER_OUTPUT: 10:25:45 INFO - 2016-02-15 10:25:45,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:46 INFO - 2016-02-15 10:25:45,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 165826560 10:25:46 INFO - 2016-02-15 10:25:45,846 DEBUG : BROWSER_OUTPUT: 10:25:47 INFO - 2016-02-15 10:25:47,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:48 INFO - 2016-02-15 10:25:48,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 163667968 10:25:48 INFO - 2016-02-15 10:25:48,167 DEBUG : BROWSER_OUTPUT: 10:25:50 INFO - 2016-02-15 10:25:50,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:50 INFO - 2016-02-15 10:25:50,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 169078784 10:25:50 INFO - 2016-02-15 10:25:50,715 DEBUG : BROWSER_OUTPUT: 10:25:55 INFO - 2016-02-15 10:25:55,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:55 INFO - 2016-02-15 10:25:55,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 173596672 10:25:55 INFO - 2016-02-15 10:25:55,568 DEBUG : BROWSER_OUTPUT: 10:25:58 INFO - 2016-02-15 10:25:58,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:58 INFO - 2016-02-15 10:25:58,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 174145536 10:25:58 INFO - 2016-02-15 10:25:58,621 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38446/tests/kraken/driver.html?testName=ai-astar) 10:26:00 INFO - 2016-02-15 10:26:00,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 232931328 10:26:00 INFO - 2016-02-15 10:26:00,495 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;102;109;109;109;99;109;108;98 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;121;153;162;127;144;151;121;165;123 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;159;160;163;161;159;162;161;159 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;72;151;71;71;72;71;163;72 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;133;92;92;93;133;92;93;131 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;108;109;111;109;111;109;109;110 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;148;145;145;145;147;146;146;146;146 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;94;95;95;95;95;97;96 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;58;60;58;59;59;59;56;57 10:26:00 INFO - 2016-02-15 10:26:00,499 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;63;65;65;64;64;64;65 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;77;79;78;78;79;85;79;80;81 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;111;117;116;110;110;128;116;130;124 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;145;152;139;147;134;140;137;138;132 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;67;62;62;65;65;61;65;62;65 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,858 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: __startTimestamp1455560760497__endTimestamp 10:26:00 INFO - 2016-02-15 10:26:00,500 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,501 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:26:00 INFO - 2016-02-15 10:26:00,501 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:26:00 INFO - 2016-02-15 10:26:00,501 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.00 Median:109.00 stddev:4.50 (4.1%) stddev-sans-first:4.71 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 102.0 109.0 109.0 109.0 99.0 109.0 108.0 98.0 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.50 stddev:16.99 (11.5%) stddev-sans-first:17.99 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: Values: 144.0 121.0 153.0 162.0 127.0 144.0 151.0 121.0 165.0 123.0 10:26:00 INFO - 2016-02-15 10:26:00,502 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,503 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.42 (0.9%) stddev-sans-first:1.50 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 159.0 160.0 163.0 161.0 159.0 162.0 161.0 159.0 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.30 Median:72.00 stddev:35.85 (49.8%) stddev-sans-first:37.79 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 72.0 151.0 71.0 71.0 72.0 71.0 163.0 72.0 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:92.00 stddev:19.36 (21.0%) stddev-sans-first:20.01 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 133.0 92.0 92.0 93.0 133.0 92.0 93.0 131.0 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 10:26:00 INFO - 2016-02-15 10:26:00,504 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 108.0 109.0 111.0 109.0 111.0 109.0 109.0 110.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: Values: 145.0 148.0 145.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 97.0 96.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:1.20 (2.0%) stddev-sans-first:1.20 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 58.0 60.0 58.0 59.0 59.0 59.0 56.0 57.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 65.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.27 (2.9%) stddev-sans-first:2.35 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 79.0 78.0 78.0 79.0 85.0 79.0 80.0 81.0 10:26:00 INFO - 2016-02-15 10:26:00,505 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:116.50 stddev:7.22 (6.2%) stddev-sans-first:7.63 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: Values: 116.0 111.0 117.0 116.0 110.0 110.0 128.0 116.0 130.0 124.0 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:139.50 stddev:6.11 (4.4%) stddev-sans-first:6.42 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: Values: 138.0 145.0 152.0 139.0 147.0 134.0 140.0 137.0 138.0 132.0 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:65.00 stddev:1.93 (3.0%) stddev-sans-first:2.05 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: Values: 64.0 67.0 62.0 62.0 65.0 65.0 61.0 65.0 62.0 65.0 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:26:00 INFO - 2016-02-15 10:26:00,506 DEBUG : BROWSER_OUTPUT: 10:26:01 INFO - 2016-02-15 10:26:01,249 INFO : Browser exited with error code: 0 10:26:01 INFO - 2016-02-15 10:26:01,297 INFO : Completed test kraken (00:01:00) 10:26:01 INFO - 2016-02-15 10:26:01,297 INFO : Starting test v8_7 10:26:01 INFO - 2016-02-15 10:26:01,297 DEBUG : operating with platform_type : linux_ 10:26:01 INFO - 2016-02-15 10:26:01,297 INFO : Initialising browser for v8_7 test... 10:26:01 INFO - 2016-02-15 10:26:01,304 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptxc5PQ/profile http://localhost:38446/getInfo.html 10:26:05 INFO - 2016-02-15 10:26:05,754 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:26:05 INFO - 2016-02-15 10:26:05,754 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:26:05 INFO - 2016-02-15 10:26:05,754 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:26:05 INFO - 2016-02-15 10:26:05,754 DEBUG : BROWSER_OUTPUT: __metrics 10:26:06 INFO - 2016-02-15 10:26:06,004 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:26:07 INFO - 2016-02-15 10:26:07,413 INFO : Browser initialized. 10:26:07 INFO - 2016-02-15 10:26:07,413 INFO : Running cycle 1/1 for v8_7 test... 10:26:07 INFO - 2016-02-15 10:26:07,414 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptxc5PQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:26:19 INFO - 2016-02-15 10:26:19,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 132694016 10:26:19 INFO - 2016-02-15 10:26:19,160 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38446/tests/v8_7/run.html (next: http://localhost:38446/tests/v8_7/run.html) 10:26:40 INFO - 2016-02-15 10:26:40,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 424984576 10:26:40 INFO - 2016-02-15 10:26:40,814 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: |0;Richards;168.37851490149856 10:26:40 INFO - 2016-02-15 10:26:40,815 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.7175094712568 10:26:40 INFO - 2016-02-15 10:26:40,816 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 10:26:40 INFO - 2016-02-15 10:26:40,816 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5213.541666666667 10:26:40 INFO - 2016-02-15 10:26:40,816 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 10:26:40 INFO - 2016-02-15 10:26:40,816 DEBUG : BROWSER_OUTPUT: |5;Earley;557.7244841048522 10:26:40 INFO - 2016-02-15 10:26:40,817 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 10:26:40 INFO - 2016-02-15 10:26:40,817 DEBUG : BROWSER_OUTPUT: |7;RegExp;24439.024390243903 10:26:40 INFO - 2016-02-15 10:26:40,817 DEBUG : BROWSER_OUTPUT: |8;Splay;507.61421319796955 10:26:40 INFO - 2016-02-15 10:26:40,817 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:26:40 INFO - 2016-02-15 10:26:40,817 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:26:40 INFO - 2016-02-15 10:26:40,818 DEBUG : BROWSER_OUTPUT: __startTimestamp1455560800807__endTimestamp 10:26:40 INFO - 2016-02-15 10:26:40,818 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,818 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:26:40 INFO - 2016-02-15 10:26:40,818 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:26:40 INFO - 2016-02-15 10:26:40,818 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: Values: 168.4 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.72 Median:164.72 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: Values: 164.7 10:26:40 INFO - 2016-02-15 10:26:40,819 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,820 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,820 DEBUG : BROWSER_OUTPUT: Values: 279.4 10:26:40 INFO - 2016-02-15 10:26:40,820 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,820 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,820 DEBUG : BROWSER_OUTPUT: Values: 5213.5 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: Values: 941.6 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:557.72 Median:557.72 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: Values: 557.7 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: Values: 10526.3 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,821 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24439.02 Median:24439.02 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: Values: 24439.0 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:507.61 Median:507.61 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: Values: 507.6 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:26:40 INFO - 2016-02-15 10:26:40,822 DEBUG : BROWSER_OUTPUT: 10:26:41 INFO - 2016-02-15 10:26:41,565 INFO : Browser exited with error code: 0 10:26:41 INFO - 2016-02-15 10:26:41,582 INFO : Completed test v8_7 (00:00:40) 10:26:41 INFO - 2016-02-15 10:26:41,852 INFO : Completed test suite (00:20:13) 10:26:41 INFO - 2016-02-15 10:26:41,852 DEBUG : Working with test: dromaeo_css 10:26:41 INFO - 2016-02-15 10:26:41,852 DEBUG : Generating results file: dromaeo_css 10:26:41 INFO - 2016-02-15 10:26:41,854 DEBUG : Working with test: kraken 10:26:41 INFO - 2016-02-15 10:26:41,854 DEBUG : Generating results file: kraken 10:26:41 INFO - 2016-02-15 10:26:41,855 INFO : javascript benchmark 10:26:41 INFO - 2016-02-15 10:26:41,855 DEBUG : Working with test: v8_7 10:26:41 INFO - 2016-02-15 10:26:41,855 DEBUG : Generating results file: v8_7 10:26:41 INFO - 2016-02-15 10:26:41,856 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:41 INFO - 2016-02-15 10:26:41,922 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:26:41 INFO - 2016-02-15 10:26:41,922 DEBUG : process_Request line: dromaeo_css 7345.93 graph.html#tests=[[72,53,35]] 10:26:41 INFO - 2016-02-15 10:26:41,923 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:41 INFO - 2016-02-15 10:26:41,962 DEBUG : process_Request line: kraken 1474.90 graph.html#tests=[[232,53,35]] 10:26:41 INFO - 2016-02-15 10:26:41,962 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:26:42 INFO - 2016-02-15 10:26:42,003 DEBUG : process_Request line: v8_7 23264.74 graph.html#tests=[[230,53,35]] 10:26:42 INFO - 2016-02-15 10:26:42,004 INFO : javascript benchmark 10:26:42 INFO - 2016-02-15 10:26:42,008 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3313.78460400074, 3380.0704806178283, 3403.995821232738, 3410.13041674373, 3427.828608569571, 5591.7204139793, 5619.4099619539875, 5631.07087330591, 5651.491365777074, 5652.0, 5631.943680563193, 5648.491635752782, 5654.434556544344, 5661.1508273758955, 5668.971655141719, 5034.949650503485, 5075.923861142086, 5131.974340128294, 5163.1480805667015, 5228.0, 5066.594672426197, 5082.364704411949, 5136.794528218867, 5166.940777140677, 5186.7925282988635, 5142.845714628567, 5187.507186817265, 5198.870028249286, 5206.271122042917, 5207.791688332462, 5140.306058682105, 5155.304033955405, 5200.6099542534275, 5222.817201397933, 5237.188235823453, 4959.900801983977, 4977.776000080005, 5051.711813487574, 5067.77195026221, 5071.011152825164, 5400.513953744182, 5439.292891924025, 5440.700761458118, 5441.1838224266285, 5447.346318441812, 5820.88358232833, 6081.3006504252135, 6086.878262434727, 6088.634681919099, 6094.908576371358, 5968.4031596840405, 6000.729967151445, 6021.277446706424, 6045.183900173464, 6055.182550355734, 5631.493165615114, 5644.181593668936, 5646.774129034875, 5650.971745141289, 5672.319321681424, 6038.456538911519, 6134.969325153345, 6139.416755408229, 6139.846503837351, 6148.200733904564, 5850.268716410449, 5902.970485147547, 5913.704314784243, 5914.319853216849, 5950.434708702666, 6075.301340345917, 6085.056816193497, 6100.847478812976, 6106.236720409949, 6111.755529778759, 5822.388649191858, 5868.67722275279, 5913.76344946206, 6036.0644100164545, 6046.516278697693, 5919.970400147971, 5956.821295361146, 5996.37038110992, 6037.78867739627, 6047.395260474005, 4585.220512512881, 4594.333821595917, 4607.401037865056, 4614.446266448048, 4629.699069560468, 4061.431399604058, 4138.565450627701, 4141.52372477169, 4144.212599606065, 4159.833606655699, 5641.0, 5707.34365547959, 5707.34365547959, 5711.3146422428745, 5747.971260143756, 6061.878762424727, 6099.2985806632805, 6101.237345331833, 6111.052786818051, 6120.051392034242, 5600.551955843523, 5608.130739735266, 5740.13897915316, 5753.4821866031425, 5787.479126878601, 5252.0, 5283.07546179417, 5291.470852914755, 5293.311869456946, 5315.043292207362, 6226.377362263828, 6258.123862659231, 6260.530460215502, 6262.0, 6272.937270627235, 5839.912401314069, 5939.732712027882, 6067.453929146398, 6141.785037523665, 6191.81424557264, 6253.749850006131, 6271.498280137487, 6277.654728989949, 6277.905831412441, 6293.905591416041, 6027.819165425044, 6036.547258955684, 6039.0, 6047.637141771508, 6056.757729690763, 5833.241678581757, 5932.584719069796, 5943.910841337297, 6011.609245399035, 6130.295016073209, 5917.3490915998345, 5947.881042379042, 5980.312264089685, 5999.49004334619, 6003.6397816131175, 5910.586258962004, 5961.463468287875, 5977.073553599199, 5986.6707331097205, 5992.67040312787, 5604.131359639263, 5719.256496655408, 5724.627899186539, 5795.1017592273265, 5831.067029275296, 5932.0508718604815, 5964.522838172849, 5999.5800293979, 6004.219451471456, 6010.33886272501, 5605.5515558756015, 5816.272965879265, 5833.212516310244, 5839.0949402842625, 5845.473907348359], "unit": "ms", "name": "dojo.html", "value": 5567.248217581077}, {"lowerIsBetter": false, "replicates": [583.670226322128, 634.5684934244717, 643.3470027921658, 645.0421124629926, 648.8507643242053, 32493.51259731103, 41182.17635647289, 41472.37791433131, 41513.37729934046, 41550.79224603876, 46654.300185497246, 47087.29369059458, 47136.52863471373, 47176.29235561469, 47217.291740623834, 8102.311303539206, 8240.258376746091, 9113.0886911309, 9284.582193801261, 9288.256939444862, 10774.676759697222, 11018.889811101906, 11048.447577621127, 11054.226204165672, 11066.612668556601, 10802.405867677315, 10912.127029837595, 10919.181061420386, 10921.836172457419, 10925.0, 8344.123866993968, 8531.616077276538, 8561.871571926426, 10710.46447677617, 10888.727781805439, 10636.20228482859, 10739.087177589914, 10808.891911080867, 10813.297135686234, 10820.72948176294, 43086.78456607728, 43490.56509434897, 43491.34762978558, 43565.0, 43630.78184609057, 3679.632036796326, 3688.704903607705, 3788.29916465452, 3799.4870692456443, 4058.2492238935597, 32725.0, 32899.17752056194, 33039.50440743391, 33387.16532086693, 35169.64830351689, 3899.493065901443, 3912.334903066457, 3925.6074392560517, 3978.3598007822807, 3979.985103798542, 294222.0, 297151.0, 297583.0, 298814.50592747115, 299022.0, 58776.70611646914, 59585.106223406685, 74267.62866185742, 75337.62331188309, 75470.0, 65343.0, 65394.346056539776, 65481.345186548475, 65544.0, 65662.34337656658, 15798.289076991563, 15814.288357023732, 15827.208639567976, 15832.129232892072, 15897.761533577006, 11455.369954652575, 11769.88230117705, 11853.703657408461, 12065.517379304729, 12142.45358958849, 21964.231251906105, 22563.0, 22622.493513505433, 22643.0, 22653.660195097087, 8025.759227223192, 8355.206255405727, 8425.272819072075, 8471.237588617054, 8476.660933562713, 983.3215081593678, 1076.56399158341, 1117.279354816139, 1124.58952482345, 1151.6084531259412, 28369.0, 28724.569131463046, 28848.423031539252, 29039.709602904124, 29402.411951760845, 1075.961696962435, 1122.4443900269418, 1171.1918776044672, 1201.6755476021426, 1210.1336230742868, 14756.704865902622, 14987.250637468083, 15496.767548486781, 17725.0, 17980.460586182435, 408765.0, 408864.0, 410889.0, 411090.0, 411213.0, 58618.706906466046, 58708.706456468295, 58886.41113588895, 59350.70324648349, 59565.70217148887, 1350.156152404747, 1374.2579007336126, 1441.988426145542, 1443.4154167562153, 1451.992740036293, 34541.13647158841, 34647.307053858276, 34761.304773903874, 34872.12819679528, 35081.82459087688, 53791.193132102264, 54439.72780136232, 54440.45559544354, 54522.727386362814, 54596.45403545914, 317140.0, 318634.0, 318920.0, 319121.0, 320837.0, 35725.46411803773, 35797.82101089582, 36333.45499817452, 36416.81791591025, 36427.45358819567, 46805.29792053054, 46927.0, 47306.29040564325, 47751.76124119357, 48183.0, 39014.837388219785, 39650.0, 39716.0, 40028.19943601053, 40282.79858600688, 38556.614433855306, 39995.80002099971, 40238.45303100155, 40556.0, 40604.98487537835, 38777.61222387853, 39168.216635666555, 39796.80101599474, 39808.40287395749, 39855.40216896691, 34693.0, 35811.462828057076, 35919.46120808242, 35977.0, 36262.09344766402, 26888.59667105034, 27242.863785680944, 27246.04638837631, 27247.31881702894, 27356.042538511058], "unit": "ms", "name": "ext.html", "value": 20491.001249715486}, {"lowerIsBetter": false, "replicates": [390.8846890167402, 395.8990457433355, 397.7673061259162, 398.9122393073523, 399.18366939608495, 15522.844771552282, 16977.83022169778, 18177.63644727105, 18296.542586435346, 18307.267709291627, 10951.671449856498, 11209.775804483905, 11324.094072474203, 18178.363757268497, 18446.44660660179, 5094.057599344133, 5216.634835561512, 5217.973910130444, 5218.295530103444, 5219.9478005220035, 3974.6621537169376, 4032.1532478179615, 5148.150555158394, 5557.305336832896, 5719.542436605082, 5657.632253903504, 5686.658800471985, 5687.516561092312, 5700.629459085167, 5710.114932185497, 5535.335759708821, 5642.238297829782, 5652.152177173436, 5654.46282603152, 5655.4910058094965, 5437.02133615949, 5449.945500544984, 5452.536534394581, 5461.590380721422, 5470.452954704498, 19986.10062547189, 20943.68584471234, 21328.360149195392, 21374.145034198613, 21429.0, 2273.6475846243857, 2318.4088057545387, 2369.7274813396507, 2376.66726658268, 2378.9762102378927, 9778.706638800848, 9950.0, 11005.889941100566, 11010.39442830644, 14043.22762248076, 1952.9902350488157, 1962.8724132931313, 1986.5728868293386, 2001.789812069741, 2032.2683833819813, 61596.384036159514, 61889.38110618926, 62395.37604623941, 62704.0, 63086.68456657733, 10683.519241634145, 10971.561137554409, 11118.0, 11142.777144457066, 11182.161337899528, 14533.200673962821, 14536.345864436125, 14546.472620374709, 14559.927200364142, 14560.344784484723, 7772.805679858049, 7790.0, 7825.569593672402, 7844.84310313802, 7846.097698764601, 7456.366208872307, 7482.47622666419, 7579.317861392501, 7820.960895195488, 7847.887969928505, 4521.886952826206, 4562.520935301745, 4668.8132474701315, 4754.9286760698615, 4952.678075925053, 1689.133425034388, 1944.6013567218686, 1978.7526559180103, 1994.2521554417094, 2001.3595649392346, 1011.4133802394593, 1027.1525991057408, 1093.0, 1129.4635048352131, 1153.7692461507731, 14832.92583537097, 17048.2328295227, 17192.27161134501, 18083.54791130232, 18293.7255941161, 964.9179819715263, 982.5627595719836, 1012.7417508535276, 1064.1912146768511, 1073.9677809665723, 9578.031143780025, 9874.21006319507, 9901.455419951828, 9941.900580994243, 9953.402795832273, 668893.0, 670798.0, 685955.0, 695905.0, 703750.0, 78392.60803695946, 85124.14875851286, 86509.0, 87490.56254718686, 87498.0, 1183.1008433590532, 1193.1826698711411, 1213.3144773203112, 1213.6844420450745, 1215.392303848076, 15239.0, 15610.375584976928, 15741.527754167393, 15813.920930395274, 15845.762313565076, 32620.673793261765, 33255.0, 33795.32409351848, 33889.322213556086, 34980.30039399147, 42656.57343426526, 44692.0, 48869.26696099633, 50454.49545504498, 50458.0, 9638.95180524093, 9703.466309353053, 9718.805623887623, 9798.706038818847, 9832.705018849447, 11292.15308851823, 11359.602413915472, 11362.488688008894, 11409.543618255177, 12453.439595218055, 14491.492797752027, 14558.4904528341, 15006.399744010554, 15390.0, 15917.681646366776, 14289.42842286297, 14490.058146220463, 15377.615559611098, 15997.1201583914, 16710.16449177512, 12570.308633025272, 15006.324715388053, 15122.243887805786, 15310.693786124439, 16681.0, 9325.026784651327, 9599.664011759554, 9641.469719165232, 9658.613655453984, 9735.659251926148, 10084.14284785772, 11597.0, 15035.248237588296, 15048.548543543711, 15258.08451492914], "unit": "ms", "name": "jquery.html", "value": 9154.241161180937}, {"lowerIsBetter": false, "replicates": [1565.4755656854952, 1773.8314860088292, 1799.0421073637995, 1853.2123847364876, 1867.9533011674707, 8001.679932802688, 8238.588070596476, 8261.628226729797, 8261.876071858927, 8261.958690206548, 7296.270372962715, 7429.702811887531, 7849.136594974562, 8093.595320233994, 8171.591420428985, 2376.3583832365293, 2396.7123945126523, 2421.237310247275, 2421.2978236311446, 2422.067504010951, 2045.0388317490756, 2413.505231427553, 2447.021191523396, 2455.0793452455327, 2461.089396923141, 2059.969100463494, 2357.2221167014845, 2411.03558576569, 2413.4690368119072, 2414.8309618326725, 2348.084247143624, 2385.522895420923, 2388.3073908566494, 2392.091005417939, 2398.364433425135, 2328.860268383902, 2355.3405046586813, 2360.917367892133, 2381.452265978817, 2433.7566243375522, 8145.51126932386, 8222.917770822274, 8241.134680858544, 8244.134365891556, 8244.876326855101, 4902.093112774148, 4941.308216849644, 4988.67573607718, 4999.12515309823, 4999.32509111269, 3138.5606015157896, 3146.921326966821, 3207.134073800061, 3243.497257925025, 3278.999905028989, 1023.918086553074, 1024.9289492480302, 1040.5057597641135, 1053.1153830782102, 1066.2855886556026, 11390.316581005083, 11412.942935285271, 11421.543138274543, 11423.314601123959, 11438.771224575461, 4323.567643235651, 4329.567043295709, 4382.342648602735, 4410.095930334273, 4414.09511050234, 9764.707058788248, 9793.804123917482, 9801.607935682636, 9811.607535698635, 9819.36174148678, 4993.350864387607, 4993.6005119590345, 4994.101061808837, 4997.0505603935135, 5003.949960500421, 4480.059187570581, 4493.932591011137, 4519.231730605805, 4531.456225252925, 4531.592156705847, 3931.095847954929, 3974.16542526067, 3997.380406037069, 4000.159966407029, 4053.6351728344002, 1128.6670432222513, 1206.7284860906225, 1236.5486597392066, 1262.1921969939247, 1265.8987281017496, 1101.801675698382, 1130.909527237819, 1140.1391949078393, 1377.6211541826078, 1460.9919155782477, 7834.921650783534, 7864.41016923733, 7922.841543169105, 7946.6424010919645, 7968.482048666818, 1176.3177357132843, 1187.1689817128045, 1194.75507520958, 1211.2429731417865, 1224.7489264700714, 6108.664023478751, 6164.137020817089, 6190.0, 6197.163382943335, 6204.968975155095, 9441.669541566149, 9495.90504094964, 9553.187979021723, 9621.374610650286, 9633.855492167622, 9446.149846513847, 9490.810183796286, 9504.47725375111, 9627.759306017406, 9650.855237171449, 7783.182765809622, 7797.80505487356, 7838.921610783933, 7888.329491993245, 7897.17079706634, 7820.0, 7859.567723775019, 7913.327367173854, 7933.206679332021, 7961.044674639081, 8788.296936244957, 8835.11648835137, 8948.149925757043, 8998.59506322204, 9069.591868365807, 9143.862842057508, 9242.214411775074, 9248.815023699623, 9249.583768730557, 9261.305402094735, 6908.412784913137, 6984.161900571964, 6987.1266091738535, 6998.16022077354, 7003.124609423822, 7565.205653406313, 7578.317951384402, 7596.924030759843, 7598.0502437195355, 7645.273698998586, 6711.4966377520905, 7038.507304488637, 7134.750283740044, 7155.356017958408, 7254.129504459287, 6541.574797638138, 7363.963180184065, 7417.443691723034, 7516.549007059594, 7573.9242607573215, 7354.043974283309, 7384.224656411215, 7385.335319821242, 7395.075615548057, 7400.333969942731, 6486.4486518646445, 6520.576162549419, 6520.9347906520325, 6536.281009088902, 6541.443977261986, 6590.604563726191, 6735.49483788708, 6742.494312926452, 6750.0, 6782.593044417351], "unit": "ms", "name": "mootools.html", "value": 4721.593545302806}, {"lowerIsBetter": false, "replicates": [341.513343485533, 361.81728227245253, 367.9025058359535, 368.8432416223105, 372.9403295472724, 6045.455908968192, 6089.78685745999, 6130.632162070279, 6151.138840562314, 6151.784687535937, 5775.249217601706, 5847.356790753014, 5916.378780228068, 6010.819675409744, 6034.366391528881, 4691.179043667362, 4693.0, 4721.881952951187, 4726.90546189076, 4737.407824021997, 4451.243288640939, 4723.3859598252175, 4726.763661816913, 4730.385049943519, 4731.810727570893, 4477.753723545204, 4551.886202844938, 4685.976570117145, 4687.109449204657, 4692.41344831896, 4638.814447422099, 4655.650826188049, 4658.114958157973, 4664.463586687541, 4674.462436819776, 4164.167166566668, 4166.66666666666, 4171.478565179353, 4172.603602657743, 4179.0, 5626.578006649518, 5697.743601537941, 5740.454656807597, 5744.454276843693, 5750.482456578886, 5419.160030195326, 5431.456854314576, 5437.265969094161, 5438.048341540254, 5439.428859969686, 6416.358364163593, 6430.517711171634, 6434.517411194179, 6439.8068057958335, 6441.291457939623, 4538.228501154778, 4539.432570928634, 4542.841000564998, 4544.363789069533, 4555.362249285103, 6536.05227242052, 6578.309277525838, 6658.733650653968, 6661.333866613349, 6673.299303573152, 4648.465426475998, 4654.557817007379, 4656.813727450932, 4657.347971284023, 4661.184292748823, 4715.104130215248, 4718.504557021532, 4724.622030237572, 4725.787339569728, 4726.692764970266, 5411.5129638331955, 5422.6475279106735, 5423.810166644227, 5424.321959755031, 5424.83725488236, 6268.968655156695, 6459.806205813833, 6470.4823614110755, 6474.643894585749, 6478.676066196671, 1629.144699033017, 1629.5518732348698, 1630.168614006865, 1630.5515983104503, 1631.9755203671955, 1103.315944114654, 1139.6922830835629, 1144.3191301175787, 1157.924734892246, 1162.0645380468634, 6257.0, 6259.749610015549, 6267.62394256346, 6267.96866015667, 6271.216097987752, 6460.3862633049785, 6608.96695516529, 6635.568688035262, 6638.4689224861895, 6641.0, 6176.3514830943, 6207.224096987877, 6319.968400158062, 6322.747090116344, 6328.177336946167, 3573.3925232710503, 3602.0, 3604.387254166798, 3604.747667663291, 3611.4221724524477, 6687.0, 6863.073485079451, 6867.141607299088, 6868.313168683192, 6875.621840798804, 6792.864142717118, 6823.55646882951, 6850.828729281808, 6861.725530978705, 6872.828179295558, 6845.623490707959, 6866.931330686629, 6870.3473170048765, 6876.587404755631, 6877.243503214642, 6542.574732642363, 6656.500762442933, 6696.029075784081, 6704.832379190364, 6719.563228390139, 6596.30738772422, 6635.336466353519, 6638.17022872141, 6655.367740064686, 6659.2008958925235, 6892.517523773287, 6895.724171033103, 6899.48253880971, 6901.137357830271, 6904.620245886525, 4580.358749774968, 4616.884577885579, 4673.929891051569, 4680.134175177467, 4682.15721170179, 6674.833129171615, 6704.4301234395625, 6725.0, 6726.39462448382, 6729.596224226562, 6507.479401647952, 6511.153550038654, 6513.54405191632, 6519.217693876765, 6522.510811689048, 6439.517036222208, 6491.188601424822, 6527.086207930798, 6530.771423000172, 6532.444742196966, 6401.487880969418, 6403.039544068427, 6409.9679501602195, 6410.647414392253, 6414.711337989895, 6499.805005849832, 6534.705938232886, 6537.248216454978, 6540.542162048611, 6546.869062618816, 6225.470834979077, 6339.207599050119, 6340.112384266298, 6349.0476428536085, 6352.491800655844], "unit": "ms", "name": "prototype.html", "value": 4901.585910908995}, {"lowerIsBetter": false, "replicates": [789.8380831929454, 888.0, 899.9820003599932, 904.4934836491569, 924.9260059195263, 12580.182288151263, 13248.867511324885, 13291.069625126222, 13331.466741330336, 13683.0, 12864.485420583165, 13169.275689837055, 13806.30968451576, 13833.239171845544, 13863.792043119362, 724.0189543169009, 730.3025610541946, 863.2662237098464, 881.0, 886.366248132585, 872.4852337121097, 876.3558784293539, 882.0782282514788, 882.5190271302156, 882.5587206396801, 923.2844545477275, 930.5905401623298, 931.3759780946782, 931.4690626342987, 931.8741969834088, 761.402299195132, 768.1435199752264, 916.225789208118, 934.7943452440452, 937.1191080384485, 687.9690413931385, 693.0332186599716, 694.2883544367014, 694.447913908444, 695.151914664109, 12829.358532073453, 12841.807372889414, 12846.229226246362, 12878.87121128786, 12909.0, 11582.826257606142, 11967.880321196764, 12023.879761202363, 12407.627771166879, 12814.35928203586, 10405.323653962469, 10739.731506712316, 10801.729956751065, 10820.404877731722, 10854.511546980404, 3736.3461394255896, 3794.7343685941996, 3806.2197249563774, 3813.656770890633, 3819.102510909934, 45349.77325113386, 46222.0, 47197.292040619075, 47655.76172119117, 47700.045999079826, 10286.691399258034, 10397.0, 10418.374897506174, 10488.423136727553, 10597.311174773615, 17508.387206447715, 17509.12454377276, 17554.91222543879, 17563.912180439016, 17580.208890599955, 6950.54821436605, 7058.823529411806, 7295.0, 7635.732749353857, 7821.374290056782, 4117.3618089196225, 4277.636400905895, 4435.401220835211, 4465.129299786576, 4508.368828364031, 3176.4123637127204, 3203.9038828835173, 3206.3106432117206, 3208.51872219169, 3208.69517395847, 603.8912995660735, 609.2688773471851, 611.3000614296606, 619.2166908860295, 641.377863472431, 579.2469789273927, 699.5103427600599, 704.1479809430544, 715.377621469325, 719.9712011519481, 8423.536705481258, 8648.913510864812, 8777.648894044167, 8785.780355491035, 8872.423292485968, 532.6165161084014, 573.8479302984713, 717.6913927011435, 722.5159143373952, 741.8108382362464, 3965.266425711253, 4039.9192016159514, 4113.85601503946, 4121.670266378743, 4137.834486620502, 61570.69214653898, 62531.37468625347, 62630.37369626245, 62679.0, 62734.43163920938, 49262.50737492651, 49932.25101623406, 50216.233782466465, 51794.0, 55846.441535584934, 46990.76504617455, 49702.25446618304, 50209.497905020486, 50428.49571504238, 50495.24257136146, 8485.57572121379, 8553.101924297858, 8597.226249637313, 9037.412568183046, 9151.222146117654, 36152.096197595274, 37323.62676373201, 37601.05997349979, 37728.62271377251, 37925.431118533794, 49000.0, 49072.0, 49105.263421047996, 49130.75434622947, 49924.75037624789, 11325.433728313716, 11734.589289374831, 11986.460609272777, 12032.699182520508, 12079.27524348542, 11926.463309151282, 12050.578229761917, 12066.698332541757, 12116.575919842764, 12833.0, 11599.130065245308, 11968.581099661471, 11982.520699172284, 11995.880041199825, 12028.699282518008, 11407.543698251977, 11600.535978560763, 11627.069834413058, 11718.414079296172, 11957.641270761891, 10720.73198170052, 10768.2147485711, 11113.055390291916, 11156.163287753614, 11194.496247669038, 9466.384684995453, 9475.33672642936, 9493.620255189715, 9811.509424528887, 9829.508524573599, 9580.730598171118, 9581.185599224144, 9628.9037109628, 9821.263405244492, 10096.596136154472], "unit": "ms", "name": "yui.html", "value": 6501.152553406219}], "name": "dromaeo_css", "value": 7345.930771966748}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 102.0, 109.0, 109.0, 109.0, 99.0, 109.0, 108.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 106.0}, {"lowerIsBetter": true, "replicates": [144.0, 121.0, 153.0, 162.0, 127.0, 144.0, 151.0, 121.0, 165.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 160.0, 163.0, 161.0, 159.0, 162.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 72.0, 151.0, 71.0, 71.0, 72.0, 71.0, 163.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 133.0, 92.0, 92.0, 93.0, 133.0, 92.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 108.0, 109.0, 111.0, 109.0, 111.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 148.0, 145.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 60.0, 58.0, 59.0, 59.0, 59.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 79.0, 78.0, 78.0, 79.0, 85.0, 79.0, 80.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [116.0, 111.0, 117.0, 116.0, 110.0, 110.0, 128.0, 116.0, 130.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 152.0, 139.0, 147.0, 134.0, 140.0, 137.0, 138.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 62.0, 62.0, 65.0, 65.0, 61.0, 65.0, 62.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1474.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.37851490149856], "unit": "score", "name": "Richards", "value": 209.65857799999998}, {"lowerIsBetter": false, "replicates": [164.7175094712568], "unit": "score", "name": "DeltaBlue", "value": 401.40237799999994}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [557.7244841048522], "unit": "score", "name": "Earley", "value": 1194.968159}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [24439.024390243903], "unit": "score", "name": "RegExp", "value": 37.27583333333335}, {"lowerIsBetter": false, "replicates": [507.61421319796955], "unit": "score", "name": "Splay", "value": 160.53727}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23264.741903872055}]} 10:26:42 INFO - RETURN: dromaeo_css: 7345.93 10:26:42 INFO - RETURN: kraken: 1474.90 10:26:42 INFO - RETURN: v8_7: 23264.74 10:26:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23264.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1474.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7345.93"}}} 10:26:42 INFO - Return code: 0 10:26:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:42 INFO - # TBPL SUCCESS # 10:26:42 INFO - Running post-action listener: _resource_record_post_action 10:26:42 INFO - Running post-run listener: _resource_record_post_run 10:26:43 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8392704; Write bytes: 410591232; Read time: 2660; Write time: 800724 10:26:43 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14381056; Read time: 0; Write time: 15576 10:26:43 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8392704; Write bytes: 350400512; Read time: 2660; Write time: 730988 10:26:43 INFO - Running post-run listener: _upload_blobber_files 10:26:43 INFO - Blob upload gear active. 10:26:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:26:43 INFO - Copying logs to upload dir... 10:26:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.854428 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-02-15 10:26:43.281928) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 10:26:43.285753) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009828 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455551062/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 10:26:43.336424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:26:43.336741) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1455558530.380873-672619042 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 10:26:43.386575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 10:26:43.386934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 10:26:43.387304) ========= ========= Total master_lag: 0.25 =========