builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1454953732.8 results: success (0) buildid: 20160208072426 builduid: 1d1a5e74384040d3b41c9ff1da48bc30 revision: f0d2911a9a4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.797933) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.798436) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.798776) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006286 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.822748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.823093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.836667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.836972) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.886875) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.887243) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.887731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.888049) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-08 09:48:53-- 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% 63.3M=0s 2016-02-08 09:48:53 (63.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.990369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:52.990755) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022329 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.040549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.040970) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f0d2911a9a4e --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 f0d2911a9a4e --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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-08 09:48:53,204 Setting DEBUG logging. 2016-02-08 09:48:53,204 attempt 1/10 2016-02-08 09:48:53,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f0d2911a9a4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 09:48:53,606 unpacking tar archive at: mozilla-beta-f0d2911a9a4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.734917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.735338) ========= echo f0d2911a9a4e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0d2911a9a4e'] 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f0d2911a9a4e program finished with exit code 0 elapsedTime=0.003828 script_repo_revision: 'f0d2911a9a4e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.784749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.785153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:48:53.795715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-08 09:48:53.796054) ========= /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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:54 INFO - MultiFileLogger online at 20160208 09:48:54 in /builds/slave/test-pgo 09:48:54 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 09:48:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:48:54 INFO - {'append_to_log': False, 09:48:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:48:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:48:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:48:54 INFO - 'branch': 'Mozilla-Beta', 09:48:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:54 INFO - 'config_files': ('talos/linux_config.py',), 09:48:54 INFO - 'default_actions': ('clobber', 09:48:54 INFO - 'read-buildbot-config', 09:48:54 INFO - 'download-and-extract', 09:48:54 INFO - 'populate-webroot', 09:48:54 INFO - 'create-virtualenv', 09:48:54 INFO - 'install', 09:48:54 INFO - 'run-tests'), 09:48:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:54 INFO - 'download_minidump_stackwalk': True, 09:48:54 INFO - 'download_symbols': 'ondemand', 09:48:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:54 INFO - 'installer_path': 'installer.exe', 09:48:54 INFO - 'log_level': 'info', 09:48:54 INFO - 'log_name': 'talos', 09:48:54 INFO - 'log_to_console': True, 09:48:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:54 INFO - 'opt_config_files': (), 09:48:54 INFO - 'pip_index': False, 09:48:54 INFO - 'sps_profile': False, 09:48:54 INFO - 'sps_profile_interval': 0, 09:48:54 INFO - 'suite': 'dromaeojs', 09:48:54 INFO - 'system_bits': '32', 09:48:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:54 INFO - 'title': 'talos-linux64-ix-033', 09:48:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:54 INFO - 'use_talos_json': True, 09:48:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:48:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:54 INFO - 'work_dir': 'build'} 09:48:54 INFO - ##### 09:48:54 INFO - ##### Running clobber step. 09:48:54 INFO - ##### 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: clobber 09:48:54 INFO - rmtree: /builds/slave/test-pgo/build 09:48:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:48:54 INFO - Running post-action listener: _resource_record_post_action 09:48:54 INFO - ##### 09:48:54 INFO - ##### Running read-buildbot-config step. 09:48:54 INFO - ##### 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: read_buildbot_config 09:48:54 INFO - Using buildbot properties: 09:48:54 INFO - { 09:48:54 INFO - "properties": { 09:48:54 INFO - "buildnumber": 110, 09:48:54 INFO - "product": "firefox", 09:48:54 INFO - "script_repo_revision": "production", 09:48:54 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:48:54 INFO - "repository": "", 09:48:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:48:54 INFO - "buildid": "20160208072426", 09:48:54 INFO - "slavename": "talos-linux64-ix-033", 09:48:54 INFO - "pgo_build": "True", 09:48:54 INFO - "basedir": "/builds/slave/test-pgo", 09:48:54 INFO - "project": "", 09:48:54 INFO - "platform": "ubuntu64_hw", 09:48:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:48:54 INFO - "slavebuilddir": "test", 09:48:54 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:48:54 INFO - "branch": "mozilla-beta", 09:48:54 INFO - "repo_path": "releases/mozilla-beta", 09:48:54 INFO - "stage_platform": "linux64-pgo", 09:48:54 INFO - "builduid": "1d1a5e74384040d3b41c9ff1da48bc30", 09:48:54 INFO - "revision": "f0d2911a9a4e" 09:48:54 INFO - }, 09:48:54 INFO - "sourcestamp": { 09:48:54 INFO - "repository": "", 09:48:54 INFO - "hasPatch": false, 09:48:54 INFO - "project": "", 09:48:54 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:48:54 INFO - "changes": [ 09:48:54 INFO - { 09:48:54 INFO - "category": null, 09:48:54 INFO - "files": [ 09:48:54 INFO - { 09:48:54 INFO - "url": null, 09:48:54 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2" 09:48:54 INFO - } 09:48:54 INFO - ], 09:48:54 INFO - "repository": "", 09:48:54 INFO - "rev": "f0d2911a9a4e", 09:48:54 INFO - "who": "sendchange", 09:48:54 INFO - "when": 1454953670, 09:48:54 INFO - "number": 7579238, 09:48:54 INFO - "comments": "Bug 1246054 - Fix an erroneous nsNPObjWrapper assertion. r=froydnj. a=al", 09:48:54 INFO - "project": "", 09:48:54 INFO - "at": "Mon 08 Feb 2016 09:47:50", 09:48:54 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:48:54 INFO - "revlink": "", 09:48:54 INFO - "properties": [ 09:48:54 INFO - [ 09:48:54 INFO - "buildid", 09:48:54 INFO - "20160208072426", 09:48:54 INFO - "Change" 09:48:54 INFO - ], 09:48:54 INFO - [ 09:48:54 INFO - "builduid", 09:48:54 INFO - "1d1a5e74384040d3b41c9ff1da48bc30", 09:48:54 INFO - "Change" 09:48:54 INFO - ], 09:48:54 INFO - [ 09:48:54 INFO - "pgo_build", 09:48:54 INFO - "True", 09:48:54 INFO - "Change" 09:48:54 INFO - ] 09:48:54 INFO - ], 09:48:54 INFO - "revision": "f0d2911a9a4e" 09:48:54 INFO - } 09:48:54 INFO - ], 09:48:54 INFO - "revision": "f0d2911a9a4e" 09:48:54 INFO - } 09:48:54 INFO - } 09:48:54 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2. 09:48:54 INFO - Running post-action listener: _resource_record_post_action 09:48:54 INFO - ##### 09:48:54 INFO - ##### Running download-and-extract step. 09:48:54 INFO - ##### 09:48:54 INFO - Running pre-action listener: _resource_record_pre_action 09:48:54 INFO - Running main action method: download_and_extract 09:48:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/test_packages.json 09:48:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:48:54 INFO - Downloaded 1270 bytes. 09:48:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:48:54 INFO - Using the following test package requirements: 09:48:54 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:48:54 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:54 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'jsshell-linux-x86_64.zip'], 09:48:54 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:54 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:48:54 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 09:48:54 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 09:48:54 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:54 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:48:54 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:48:54 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:54 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:48:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:54 INFO - Downloaded 21580545 bytes. 09:48:54 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 09:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:48:54 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 09:48:56 INFO - Return code: 0 09:48:56 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 09:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:48:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:56 INFO - Downloaded 21580545 bytes. 09:48:56 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 09:48:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:48:56 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 09:48:57 INFO - Return code: 0 09:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:48:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:57 INFO - Downloaded 11132038 bytes. 09:48:57 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 09:48:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:48:57 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 09:48:58 INFO - Return code: 0 09:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:48:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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 09:48:58 INFO - Downloaded 57942117 bytes. 09:48:58 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:48:58 INFO - mkdir: /builds/slave/test-pgo/properties 09:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:48:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:48:58 INFO - Contents: 09:48:58 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:48:58 INFO - Running post-action listener: _resource_record_post_action 09:48:58 INFO - Running post-action listener: set_extra_try_arguments 09:48:58 INFO - ##### 09:48:58 INFO - ##### Running populate-webroot step. 09:48:58 INFO - ##### 09:48:58 INFO - Running pre-action listener: _resource_record_pre_action 09:48:58 INFO - Running main action method: populate_webroot 09:48:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:58 INFO - '--tppagecycles', 09:48:58 INFO - '7'], 09:48:58 INFO - 'tests': ['tsvgm']}}, 09:48:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:48:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:48:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:48:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['damp', 'tps']}, 09:48:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['damp', 'tps']}, 09:48:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:48:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:58 INFO - 'other': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'other_l64': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:48:58 INFO - 'ts_paint', 09:48:58 INFO - 'tpaint', 09:48:58 INFO - 'sessionrestore', 09:48:58 INFO - 'sessionrestore_no_auto_restore']}, 09:48:58 INFO - 'svgr': {'tests': ['tsvgx', 09:48:58 INFO - 'tsvgr_opacity', 09:48:58 INFO - 'tart', 09:48:58 INFO - 'tscrollx', 09:48:58 INFO - 'cart']}, 09:48:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['tsvgx', 09:48:58 INFO - 'tsvgr_opacity', 09:48:58 INFO - 'tart', 09:48:58 INFO - 'tscrollx', 09:48:58 INFO - 'cart']}, 09:48:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'tests': ['tp5o']}, 09:48:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--e10s'], 09:48:58 INFO - 'tests': ['tp5o']}, 09:48:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--xperf_path', 09:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:58 INFO - 'tests': ['tp5n']}, 09:48:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:58 INFO - 'talos_options': ['--e10s', 09:48:58 INFO - '--xperf_path', 09:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:58 INFO - 'tests': ['tp5n']}}, 09:48:58 INFO - 'talos.zip': {'path': '', 09:48:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:58 INFO - Running post-action listener: _resource_record_post_action 09:48:58 INFO - ##### 09:48:58 INFO - ##### Running create-virtualenv step. 09:48:58 INFO - ##### 09:48:58 INFO - Running pre-action listener: _resource_record_pre_action 09:48:58 INFO - Running main action method: create_virtualenv 09:48:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:48:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:48:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:59 INFO - Using real prefix '/usr' 09:48:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:48:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:01 INFO - Installing pip.................done. 09:49:01 INFO - Return code: 0 09:49:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:01 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 09:49:01 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 09:49:01 INFO - Using env: {'DISPLAY': ':0', 09:49:01 INFO - 'HOME': '/home/cltbld', 09:49:01 INFO - 'LANG': 'en_US.UTF-8', 09:49:01 INFO - 'LANGUAGE': 'en_US:en', 09:49:01 INFO - 'LOGNAME': 'cltbld', 09:49:01 INFO - 'MAIL': '/var/mail/cltbld', 09:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:01 INFO - 'MOZ_NO_REMOTE': '1', 09:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:01 INFO - 'NO_EM_RESTART': '1', 09:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:01 INFO - 'SHELL': '/bin/bash', 09:49:01 INFO - 'SHLVL': '1', 09:49:01 INFO - 'TERM': 'linux', 09:49:01 INFO - 'TMOUT': '86400', 09:49:01 INFO - 'USER': 'cltbld', 09:49:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:01 INFO - '_': '/tools/buildbot/bin/python'} 09:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:49:01 INFO - Cleaning up... 09:49:01 INFO - Return code: 0 09:49:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:01 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:01 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 09:49:01 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 09:49:01 INFO - Using env: {'DISPLAY': ':0', 09:49:01 INFO - 'HOME': '/home/cltbld', 09:49:01 INFO - 'LANG': 'en_US.UTF-8', 09:49:01 INFO - 'LANGUAGE': 'en_US:en', 09:49:01 INFO - 'LOGNAME': 'cltbld', 09:49:01 INFO - 'MAIL': '/var/mail/cltbld', 09:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:01 INFO - 'MOZ_NO_REMOTE': '1', 09:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:01 INFO - 'NO_EM_RESTART': '1', 09:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:01 INFO - 'SHELL': '/bin/bash', 09:49:01 INFO - 'SHLVL': '1', 09:49:01 INFO - 'TERM': 'linux', 09:49:01 INFO - 'TMOUT': '86400', 09:49:01 INFO - 'USER': 'cltbld', 09:49:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:01 INFO - '_': '/tools/buildbot/bin/python'} 09:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:01 INFO - Downloading/unpacking psutil>=0.7.1 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:03 INFO - Installing collected packages: psutil 09:49:03 INFO - Running setup.py install for psutil 09:49:03 INFO - building 'psutil._psutil_linux' extension 09:49:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:49:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:49:04 INFO - building 'psutil._psutil_posix' extension 09:49:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:49:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:04 INFO - Successfully installed psutil 09:49:04 INFO - Cleaning up... 09:49:04 INFO - Return code: 0 09:49:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:04 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:04 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 09:49:04 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 09:49:04 INFO - Using env: {'DISPLAY': ':0', 09:49:04 INFO - 'HOME': '/home/cltbld', 09:49:04 INFO - 'LANG': 'en_US.UTF-8', 09:49:04 INFO - 'LANGUAGE': 'en_US:en', 09:49:04 INFO - 'LOGNAME': 'cltbld', 09:49:04 INFO - 'MAIL': '/var/mail/cltbld', 09:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:04 INFO - 'MOZ_NO_REMOTE': '1', 09:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:04 INFO - 'NO_EM_RESTART': '1', 09:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:04 INFO - 'SHELL': '/bin/bash', 09:49:04 INFO - 'SHLVL': '1', 09:49:04 INFO - 'TERM': 'linux', 09:49:04 INFO - 'TMOUT': '86400', 09:49:04 INFO - 'USER': 'cltbld', 09:49:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:04 INFO - '_': '/tools/buildbot/bin/python'} 09:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:06 INFO - Installing collected packages: mozsystemmonitor 09:49:06 INFO - Running setup.py install for mozsystemmonitor 09:49:06 INFO - Successfully installed mozsystemmonitor 09:49:06 INFO - Cleaning up... 09:49:06 INFO - Return code: 0 09:49:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:49: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 blobuploader==1.2.4 09:49:06 INFO - Using env: {'DISPLAY': ':0', 09:49:06 INFO - 'HOME': '/home/cltbld', 09:49:06 INFO - 'LANG': 'en_US.UTF-8', 09:49:06 INFO - 'LANGUAGE': 'en_US:en', 09:49:06 INFO - 'LOGNAME': 'cltbld', 09:49:06 INFO - 'MAIL': '/var/mail/cltbld', 09:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:06 INFO - 'MOZ_NO_REMOTE': '1', 09:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:06 INFO - 'NO_EM_RESTART': '1', 09:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:06 INFO - 'SHELL': '/bin/bash', 09:49:06 INFO - 'SHLVL': '1', 09:49:06 INFO - 'TERM': 'linux', 09:49:06 INFO - 'TMOUT': '86400', 09:49:06 INFO - 'USER': 'cltbld', 09:49:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:06 INFO - '_': '/tools/buildbot/bin/python'} 09:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:49:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:09 INFO - Downloading docopt-0.6.1.tar.gz 09:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:09 INFO - Running setup.py install for blobuploader 09:49:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:49:09 INFO - Running setup.py install for requests 09:49:09 INFO - Running setup.py install for docopt 09:49:09 INFO - Successfully installed blobuploader requests docopt 09:49:09 INFO - Cleaning up... 09:49:09 INFO - Return code: 0 09:49:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:09 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:09 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 09:49:09 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 09:49:09 INFO - Using env: {'DISPLAY': ':0', 09:49:09 INFO - 'HOME': '/home/cltbld', 09:49:09 INFO - 'LANG': 'en_US.UTF-8', 09:49:09 INFO - 'LANGUAGE': 'en_US:en', 09:49:09 INFO - 'LOGNAME': 'cltbld', 09:49:09 INFO - 'MAIL': '/var/mail/cltbld', 09:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:09 INFO - 'MOZ_NO_REMOTE': '1', 09:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:09 INFO - 'NO_EM_RESTART': '1', 09:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:09 INFO - 'SHELL': '/bin/bash', 09:49:09 INFO - 'SHLVL': '1', 09:49:09 INFO - 'TERM': 'linux', 09:49:09 INFO - 'TMOUT': '86400', 09:49:09 INFO - 'USER': 'cltbld', 09:49:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:09 INFO - '_': '/tools/buildbot/bin/python'} 09:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:10 INFO - Running setup.py (path:/tmp/pip-VoyW0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:10 INFO - Running setup.py (path:/tmp/pip-eV65_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:10 INFO - Running setup.py (path:/tmp/pip-N70Bg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:10 INFO - Running setup.py (path:/tmp/pip-G7wQ80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:10 INFO - Running setup.py (path:/tmp/pip-F51XP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:10 INFO - Running setup.py (path:/tmp/pip-4GbxF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:10 INFO - Running setup.py (path:/tmp/pip-3MjAuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:10 INFO - Running setup.py (path:/tmp/pip-EH5Nyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:10 INFO - Running setup.py (path:/tmp/pip-2DwvY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:10 INFO - Running setup.py (path:/tmp/pip-pnyKqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:10 INFO - Running setup.py (path:/tmp/pip-fKYAL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:10 INFO - Running setup.py (path:/tmp/pip-oaA4i_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:11 INFO - Running setup.py (path:/tmp/pip-sJNX_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:11 INFO - Running setup.py (path:/tmp/pip-I2xpCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:11 INFO - Running setup.py (path:/tmp/pip-hckEwt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:11 INFO - Running setup.py (path:/tmp/pip-w8Be_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:11 INFO - Running setup.py (path:/tmp/pip-RWwvnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:11 INFO - Running setup.py install for manifestparser 09:49:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:49:11 INFO - Running setup.py install for mozcrash 09:49:11 INFO - Running setup.py install for mozdebug 09:49:11 INFO - Running setup.py install for mozdevice 09:49:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:49:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:49:11 INFO - Running setup.py install for mozfile 09:49:11 INFO - Running setup.py install for mozhttpd 09:49:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:49:11 INFO - Running setup.py install for mozinfo 09:49:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for mozInstall 09:49:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for mozleak 09:49:12 INFO - Running setup.py install for mozlog 09:49:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for moznetwork 09:49:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for mozprocess 09:49:12 INFO - Running setup.py install for mozprofile 09:49:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for mozrunner 09:49:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:49:12 INFO - Running setup.py install for mozscreenshot 09:49:12 INFO - Running setup.py install for moztest 09:49:13 INFO - Running setup.py install for mozversion 09:49:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:49:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:13 INFO - Cleaning up... 09:49:13 INFO - Return code: 0 09:49:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:13 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:13 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 09:49:13 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 09:49:13 INFO - Using env: {'DISPLAY': ':0', 09:49:13 INFO - 'HOME': '/home/cltbld', 09:49:13 INFO - 'LANG': 'en_US.UTF-8', 09:49:13 INFO - 'LANGUAGE': 'en_US:en', 09:49:13 INFO - 'LOGNAME': 'cltbld', 09:49:13 INFO - 'MAIL': '/var/mail/cltbld', 09:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:13 INFO - 'MOZ_NO_REMOTE': '1', 09:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:13 INFO - 'NO_EM_RESTART': '1', 09:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:13 INFO - 'SHELL': '/bin/bash', 09:49:13 INFO - 'SHLVL': '1', 09:49:13 INFO - 'TERM': 'linux', 09:49:13 INFO - 'TMOUT': '86400', 09:49:13 INFO - 'USER': 'cltbld', 09:49:13 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:13 INFO - '_': '/tools/buildbot/bin/python'} 09:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:13 INFO - Running setup.py (path:/tmp/pip-lLBAAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:13 INFO - Running setup.py (path:/tmp/pip-0YbpRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:13 INFO - Running setup.py (path:/tmp/pip-WIH5bf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:13 INFO - Running setup.py (path:/tmp/pip-yL8RCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:13 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)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:13 INFO - Running setup.py (path:/tmp/pip-kKyYlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:13 INFO - Running setup.py (path:/tmp/pip-CJfLcA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:13 INFO - Running setup.py (path:/tmp/pip-xPVTU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:13 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)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:13 INFO - Running setup.py (path:/tmp/pip-lgMaa7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:13 INFO - Running setup.py (path:/tmp/pip-5DlaD6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:49:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:14 INFO - Running setup.py (path:/tmp/pip-QPNR05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:14 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)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:14 INFO - Running setup.py (path:/tmp/pip-ZRfmBq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:14 INFO - Running setup.py (path:/tmp/pip-nkQgHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:14 INFO - Running setup.py (path:/tmp/pip-MlCx1P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:14 INFO - Running setup.py (path:/tmp/pip-ka28Rq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:14 INFO - Running setup.py (path:/tmp/pip-YHHMgs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:14 INFO - Running setup.py (path:/tmp/pip-Kuzt9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:14 INFO - Running setup.py (path:/tmp/pip-dhtJLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:49:14 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)) 09:49:14 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)) 09:49:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:16 INFO - Downloading blessings-1.6.tar.gz 09:49:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:16 INFO - Installing collected packages: blessings 09:49:16 INFO - Running setup.py install for blessings 09:49:16 INFO - Successfully installed blessings 09:49:16 INFO - Cleaning up... 09:49:16 INFO - Return code: 0 09:49:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:49:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:16 INFO - Reading from file tmpfile_stdout 09:49:16 INFO - Current package versions: 09:49:16 INFO - argparse == 1.2.1 09:49:16 INFO - blessings == 1.6 09:49:16 INFO - blobuploader == 1.2.4 09:49:16 INFO - docopt == 0.6.1 09:49:16 INFO - manifestparser == 1.1 09:49:16 INFO - mozInstall == 1.12 09:49:16 INFO - mozcrash == 0.16 09:49:16 INFO - mozdebug == 0.1 09:49:16 INFO - mozdevice == 0.47 09:49:16 INFO - mozfile == 1.2 09:49:16 INFO - mozhttpd == 0.7 09:49:16 INFO - mozinfo == 0.9 09:49:16 INFO - mozleak == 0.1 09:49:16 INFO - mozlog == 3.1 09:49:16 INFO - moznetwork == 0.27 09:49:16 INFO - mozprocess == 0.22 09:49:16 INFO - mozprofile == 0.27 09:49:16 INFO - mozrunner == 6.11 09:49:16 INFO - mozscreenshot == 0.1 09:49:16 INFO - mozsystemmonitor == 0.0 09:49:16 INFO - moztest == 0.7 09:49:16 INFO - mozversion == 1.4 09:49:16 INFO - psutil == 3.1.1 09:49:16 INFO - requests == 1.2.3 09:49:16 INFO - wsgiref == 0.1.2 09:49:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:16 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:16 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 09:49:16 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 09:49:16 INFO - Using env: {'DISPLAY': ':0', 09:49:16 INFO - 'HOME': '/home/cltbld', 09:49:16 INFO - 'LANG': 'en_US.UTF-8', 09:49:16 INFO - 'LANGUAGE': 'en_US:en', 09:49:16 INFO - 'LOGNAME': 'cltbld', 09:49:16 INFO - 'MAIL': '/var/mail/cltbld', 09:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:16 INFO - 'MOZ_NO_REMOTE': '1', 09:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:16 INFO - 'NO_EM_RESTART': '1', 09:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:16 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:16 INFO - 'SHELL': '/bin/bash', 09:49:16 INFO - 'SHLVL': '1', 09:49:16 INFO - 'TERM': 'linux', 09:49:16 INFO - 'TMOUT': '86400', 09:49:16 INFO - 'USER': 'cltbld', 09:49:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:16 INFO - '_': '/tools/buildbot/bin/python'} 09:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:17 INFO - Cleaning up... 09:49:17 INFO - Return code: 0 09:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:17 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:17 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 09:49:17 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 09:49:17 INFO - Using env: {'DISPLAY': ':0', 09:49:17 INFO - 'HOME': '/home/cltbld', 09:49:17 INFO - 'LANG': 'en_US.UTF-8', 09:49:17 INFO - 'LANGUAGE': 'en_US:en', 09:49:17 INFO - 'LOGNAME': 'cltbld', 09:49:17 INFO - 'MAIL': '/var/mail/cltbld', 09:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:17 INFO - 'MOZ_NO_REMOTE': '1', 09:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:17 INFO - 'NO_EM_RESTART': '1', 09:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:17 INFO - 'SHELL': '/bin/bash', 09:49:17 INFO - 'SHLVL': '1', 09:49:17 INFO - 'TERM': 'linux', 09:49:17 INFO - 'TMOUT': '86400', 09:49:17 INFO - 'USER': 'cltbld', 09:49:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:17 INFO - '_': '/tools/buildbot/bin/python'} 09:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:17 INFO - Downloading/unpacking jsonschema 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:19 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:19 INFO - warning: no files found matching '*.txt' 09:49:19 INFO - no previously-included directories found matching 'build' 09:49:19 INFO - no previously-included directories found matching 'dist' 09:49:19 INFO - no previously-included directories found matching '.git*' 09:49:19 INFO - Installing collected packages: jsonschema, functools32 09:49:19 INFO - Running setup.py install for functools32 09:49:19 INFO - warning: no files found matching '*.txt' 09:49:19 INFO - no previously-included directories found matching 'build' 09:49:19 INFO - no previously-included directories found matching 'dist' 09:49:19 INFO - no previously-included directories found matching '.git*' 09:49:19 INFO - Successfully installed jsonschema functools32 09:49:19 INFO - Cleaning up... 09:49:19 INFO - Return code: 0 09:49:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:19 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 0x7fd31a759f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, '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-1454953730.612493-288498663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:19 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 09:49:19 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 09:49:19 INFO - Using env: {'DISPLAY': ':0', 09:49:19 INFO - 'HOME': '/home/cltbld', 09:49:19 INFO - 'LANG': 'en_US.UTF-8', 09:49:19 INFO - 'LANGUAGE': 'en_US:en', 09:49:19 INFO - 'LOGNAME': 'cltbld', 09:49:19 INFO - 'MAIL': '/var/mail/cltbld', 09:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:19 INFO - 'MOZ_NO_REMOTE': '1', 09:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:19 INFO - 'NO_EM_RESTART': '1', 09:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:19 INFO - 'SHELL': '/bin/bash', 09:49:19 INFO - 'SHLVL': '1', 09:49:19 INFO - 'TERM': 'linux', 09:49:19 INFO - 'TMOUT': '86400', 09:49:19 INFO - 'USER': 'cltbld', 09:49:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:19 INFO - '_': '/tools/buildbot/bin/python'} 09:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:19 INFO - Downloading/unpacking flake8 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:22 INFO - no previously-included directories found matching 'docs/_build' 09:49:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:22 INFO - Running setup.py install for pep8 09:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:22 INFO - no previously-included directories found matching 'docs/_build' 09:49:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:49:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:22 INFO - Cleaning up... 09:49:22 INFO - Return code: 0 09:49:22 INFO - Running post-action listener: _resource_record_post_action 09:49:22 INFO - Running post-action listener: _start_resource_monitoring 09:49:22 INFO - Starting resource monitoring. 09:49:22 INFO - ##### 09:49:22 INFO - ##### Running install step. 09:49:22 INFO - ##### 09:49:22 INFO - Running pre-action listener: _resource_record_pre_action 09:49:22 INFO - Running main action method: install 09:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:22 INFO - Reading from file tmpfile_stdout 09:49:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:49:22 INFO - Reading from file tmpfile_stdout 09:49:22 INFO - Output received: 09:49:22 INFO - Usage: mozinstall [options] installer 09:49:22 INFO - Options: 09:49:22 INFO - -h, --help show this help message and exit 09:49:22 INFO - -d DEST, --destination=DEST 09:49:22 INFO - Directory to install application into. [default: 09:49:22 INFO - "/builds/slave/test-pgo"] 09:49:22 INFO - --app=APP Application being installed. [default: firefox] 09:49:22 INFO - mkdir: /builds/slave/test-pgo/build/application 09:49:22 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'] 09:49:22 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 09:49:39 INFO - Reading from file tmpfile_stdout 09:49:39 INFO - Output received: 09:49:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:49:39 INFO - Running post-action listener: _resource_record_post_action 09:49:39 INFO - ##### 09:49:39 INFO - ##### Running run-tests step. 09:49:39 INFO - ##### 09:49:39 INFO - Running pre-action listener: _resource_record_pre_action 09:49:39 INFO - Running main action method: run_tests 09:49:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:49:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:49:39 INFO - Python 2.7.3 09:49:39 INFO - Return code: 0 09:49:39 INFO - grabbing minidump binary from tooltool 09:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:39 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 0x15e1350>, '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 0x15e2250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e26e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:49:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:49:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:49:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:39 INFO - Return code: 0 09:49:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:49:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:49:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:49:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:49:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:49:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:49:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:49:40 INFO - Return code: 0 09:49:40 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/1454945066/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:49:40 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/1454945066/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 09:49:40 INFO - Using env: {'DISPLAY': ':0', 09:49:40 INFO - 'HOME': '/home/cltbld', 09:49:40 INFO - 'LANG': 'en_US.UTF-8', 09:49:40 INFO - 'LANGUAGE': 'en_US:en', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MAIL': '/var/mail/cltbld', 09:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SHLVL': '1', 09:49:40 INFO - 'TERM': 'linux', 09:49:40 INFO - 'TMOUT': '86400', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1454953730.612493-288498663', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - '_': '/tools/buildbot/bin/python'} 09:49:40 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/1454945066/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 09:49:40 INFO - mozversion INFO | application_buildid: 20160208072426 09:49:40 INFO - mozversion INFO | application_changeset: f0d2911a9a4eade0fcf3d3d58916f49a313227e6 09:49:40 INFO - mozversion INFO | application_display_name: Nightly 09:49:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:40 INFO - mozversion INFO | application_name: Firefox 09:49:40 INFO - mozversion INFO | application_remotingname: firefox 09:49:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:49:40 INFO - mozversion INFO | application_vendor: Mozilla 09:49:40 INFO - mozversion INFO | application_version: 45.0 09:49:40 INFO - mozversion INFO | platform_buildid: 20160208072426 09:49:40 INFO - mozversion INFO | platform_changeset: f0d2911a9a4eade0fcf3d3d58916f49a313227e6 09:49:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:49:40 INFO - mozversion INFO | platform_version: 45.0 09:49:40 INFO - 2016-02-08 09:49:40,957 DEBUG : using testdate: 1454953780 09:49:40 INFO - 2016-02-08 09:49:40,957 DEBUG : actual date: 1454953780 09:49:40 INFO - 2016-02-08 09:49:40,966 INFO : starting webserver on 'localhost:53362' 09:49:40 INFO - 2016-02-08 09:49:40,967 INFO : Starting test suite talos-linux64-ix-033 09:49:40 INFO - 2016-02-08 09:49:40,967 INFO : Starting test dromaeo_css 09:49:40 INFO - 2016-02-08 09:49:40,968 DEBUG : operating with platform_type : linux_ 09:49:40 INFO - 2016-02-08 09:49:40,968 INFO : Initialising browser for dromaeo_css test... 09:49:40 INFO - 2016-02-08 09:49:40,980 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp71geJl/profile http://localhost:53362/getInfo.html 09:49:46 INFO - 2016-02-08 09:49:46,268 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:49:46 INFO - 2016-02-08 09:49:46,268 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:49:46 INFO - 2016-02-08 09:49:46,268 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:49:46 INFO - 2016-02-08 09:49:46,268 DEBUG : BROWSER_OUTPUT: __metrics 09:49:46 INFO - 2016-02-08 09:49:46,526 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] 09:49:47 INFO - 2016-02-08 09:49:47,951 INFO : Browser initialized. 09:49:47 INFO - 2016-02-08 09:49:47,951 INFO : Running cycle 1/1 for dromaeo_css test... 09:49:47 INFO - 2016-02-08 09:49:47,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp71geJl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:49:59 INFO - 2016-02-08 09:49:59,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 135192576 09:49:59 INFO - 2016-02-08 09:49:59,651 DEBUG : BROWSER_OUTPUT: 09:50:50 INFO - 2016-02-08 09:50:50,425 DEBUG : BROWSER_OUTPUT: 1454953850425 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] 09:52:59 INFO - 2016-02-08 09:52:59,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53362/tests/dromaeo/cssquery-ext.html) 09:53:00 INFO - 2016-02-08 09:53:00,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 216342528 09:53:00 INFO - 2016-02-08 09:53:00,238 DEBUG : BROWSER_OUTPUT: 09:56:02 INFO - 2016-02-08 09:56:02,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-ext.html (next: http://localhost:53362/tests/dromaeo/cssquery-jquery.html) 09:56:02 INFO - 2016-02-08 09:56:02,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 222228480 09:56:02 INFO - 2016-02-08 09:56:02,980 DEBUG : BROWSER_OUTPUT: 09:59:04 INFO - 2016-02-08 09:59:04,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53362/tests/dromaeo/cssquery-mootools.html) 09:59:05 INFO - 2016-02-08 09:59:05,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 221442048 09:59:05 INFO - 2016-02-08 09:59:05,238 DEBUG : BROWSER_OUTPUT: 10:02:06 INFO - 2016-02-08 10:02:06,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53362/tests/dromaeo/cssquery-prototype.html) 10:02:07 INFO - 2016-02-08 10:02:07,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 202653696 10:02:07 INFO - 2016-02-08 10:02:07,492 DEBUG : BROWSER_OUTPUT: 10:05:09 INFO - 2016-02-08 10:05:09,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53362/tests/dromaeo/cssquery-yui.html) 10:05:10 INFO - 2016-02-08 10:05:10,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 205524992 10:05:10 INFO - 2016-02-08 10:05:10,339 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/dromaeo/cssquery-yui.html (next: http://localhost:53362/tests/dromaeo/cssquery-dojo.html) 10:08:12 INFO - 2016-02-08 10:08:12,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 258392064 10:08:12 INFO - 2016-02-08 10:08:12,821 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,821 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:08:12 INFO - 2016-02-08 10:08:12,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:08:12 INFO - 2016-02-08 10:08:12,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:08:12 INFO - 2016-02-08 10:08:12,821 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:08:12 INFO - 2016-02-08 10:08:12,822 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3276.8197749123797;3330.250693593943;3354.3123659649773;3366.9831650841757;3374.2745309758407;5454.318210223722;5472.616916815815;5487.314085739283;5508.9999999999945;5511.090670039449;5456.781728730856;5471.644343117695;5480.890382192354;5496.890062198753;5508.118701007839;4844.07962487128;5000.274960130788;5045.697258164503;5069.163588007974;5101.132807422729;5014.247862820588;5082.618803589727;5084.186530155176;5086.033653605821;5087.287779710843;4929.926051109236;5003.874903127433;5015.874603134915;5026.321446604698;5054.241863720435;5045.192769156935;5142.897142057138;5147.124988751922;5147.845564633067;5171.405288391846;4771.737554434505;5052;5057.9494205057845;5077;5123.513266239701;5269.947300527022;5281.260623512711;5299.390570084451;5327.254184414146;5340.172273297645;5875;5925.08161235005;5928.49607783339;5930.3773103823905;5938.5546084043435;5774.595778295521;5849.356570777211;5909.054551271819;5938.970305148489;5940.108983652443;5426.810061647823;5497.147942068986;5521.861953451155;5523.6685798851395;5527.474889885495;6012.248468941382;6020.09698545213;6021.488173505301;6067.453929146398;6078;5527.861803454865;5683.8010669626365;5727.742251598688;5828.854278643068;5848.941510584925;5955.779065291605;5979.9535081361455;5989.1615173874825;5993.700314984233;6003.909941350883;5901.085331773582;5939.524838012949;5944.791932282349;5949.286085669661;5956.910646340309;5668.461496157858;5760.251167348301;5935.465808077293;5936.970315148483;5939.821805345847;4462;4528.41130653013;4528.864134075983;4543.522930092358;4553.021100463417;4057.3102572562734;4060.715749897479;4063.593640635913;4081.551029386765;4096.9795151024055;5350.491703288181;5493.450654934474;5634.070378387521;5635.915461268084;5638.295213098363;5807.186993820868;5883.14694369314;5890.116482527569;5902.61632993854;5922.73347699346;5514.172874068841;5520.199571062173;5526.336839579276;5535.169724541351;5542.445755424506;4931.778069986859;5001.824936127291;5013.423456302499;5080.618953578422;5116.513931176532;6091.725872335755;6103.969480152571;6105.48103411215;6106.908396374058;6108.908366374508;5923.229980102559;5930.377310382348;5946.940530594812;5951.91072133927;5955;5876.529877609695;5935.465808077293;5986.4013598639785;6048.84877878039;6139.355367686508;5784.132380143013;5786.247787787561;5787.131930210502;5787.536997040311;5788.594798364074;5815.360310365941;5843.181954526454;5853.09277062056;5857.062869940789;5857.941420585739;5509.669419834822;5666.9716651416475;5704.372519022987;5790.276215473066;5811.651300921958;5760.913586296293;5793.826185214451;5799.8550036249435;5801.100829371454;5802.564807639528;5451.100568406168;5725.398833122462;5733.71331433435;5736.627119237236;5737.512311453574;5631.408702086386;5839.941600584109;5907.763689452374;5940.79207227745;5977.3126090500145;5665.716714164358;5672.659640421588;5677.205191273142;5685.488306052475;5687.573431992534 10:08:12 INFO - 2016-02-08 10:08:12,823 DEBUG : BROWSER_OUTPUT: |1;ext.html;633.85738208903;637.9776707815224;638.5976834594206;646.6088016749866;652.4584594786328;40828.38757418641;41973.58026419731;42030.15939681204;42030.57969420312;42065.158696826045;46355.07289854201;46877;46966;47009;47040.2943955841;8034.236747509007;8121.30968867647;9085.682001129979;9272.907270927271;10439.947800260989;10626.521806518725;10738.463076846165;10739.677809665684;10747.140228781678;10750.623728169516;10782.46087695616;10851;10857.565697372096;10933.234673572853;10944;8209.38429617781;8404.915950840536;10958.28771129874;11203.21577489568;11208.383538905357;10545.209109316833;10684.19868509857;10684.465776711133;10685.305455145392;10698.090662293715;42184.36723449151;42431;42557.723268302;42694.78652606717;42704.35943460851;3682.594914559423;3803.2963901678277;4083.122128742305;4150.522689890671;4259.105587826529;32182.51726224085;32620;32688.182795430068;33025.174370640685;33182.50226246584;4304.397384366192;4323.632491238217;4368.737875727466;4374.212641724488;4400.911981760379;276678;277247;277544;278120;278366;58191.12713309304;59085.70457147687;67877;68316;68328;78709.21290787018;79810.20189798143;80102.59948700336;80134.59932700415;80226;16408;16744.162791860603;16745.581360465843;16756.16219189036;16783;12890.48438062467;12985.935070324587;13000.544980925622;13019.934900325437;13023.47906083765;21871.45321366947;22146.446338841335;22240.221592244194;22278.665820012713;22314.442138946655;8124.390670699721;8156;8268.586570671443;8340.332773378115;8377.204165604258;1074.1889873145724;1079.6653037558383;1117.80997230471;1140.6521011091697;1200.8739082396398;30263.697363026527;30430.239244018634;30465;30565.847170764006;31211.531827022613;1133.659902029388;1209.6414666283604;1219.536576101076;1225.2464734188588;1228.3673907937418;13816.894648428102;15806.762898556532;16004.839951600336;16086.839131608534;16681.499555013368;337208;343590;343654;344633.66099017067;344646;57354;57502.424975750546;57648.71175644095;57687;57787.711061444425;1448.5292280008828;1454.8254209494928;1462.349254581701;1465.3039806092233;1474.8820094392422;31462.056138315886;31465.52801708022;31785.523217152222;31858.840705796323;31972.84013579917;51735.2239716397;51864.481355187476;52443;52468.47531524636;52481.21278180907;326934;329079;329177;329233;329968;30875.382492349578;31155.532667010466;34561.30877382489;34625.30749385049;35128;40064.59935400609;40678.18643627052;40680.59319406887;40987.7950610245;41807.37288940729;34123;34636;34803;34950.65049349474;35199.47200791939;32821.507677385336;37779.995011224746;38067.525610835204;42445.57554424416;42775.14449711051;36940.26119477649;37182.628173717916;37884;37923.62076379201;38118;32390.514142287415;34509;34749.37042810913;35052.12369690676;35092.473612895315;26468.735312646626;27023.594646080717;34483.13792155216;34741.305173896886;36974 10:08:12 INFO - 2016-02-08 10:08:12,824 DEBUG : BROWSER_OUTPUT: |2;jquery.html;382.10015413700717;384.8013438140192;387.16565800699493;390.61914633232584;394.8598247622094;15354.385824567004;15490;16692.248848801803;18077.548061298476;18085.819141808577;17996.280148794067;18044.81955180451;18338.541536461595;18363.357282495115;18370.540736481595;6033.909491357633;6155.569110162291;6157.415045570686;6162.476189523896;6170.444659980601;4630.0739852029565;4744.264638980946;6030.246219222598;6795.7621483248095;6988.545744526615;5459.590530710193;6897.068895699092;6916.412104971084;6921.930780692204;6958.338957799001;5582.637128586629;5600.355959064719;5603.991281569336;5604.607677462579;5605.047141985852;5318.388385335697;5407.270018547485;5408.891822163574;5416.1063424534905;5437.809676661337;13929.860701392958;14110.365033573515;14120.717585648332;18486.722699159523;22683.659745103836;2317.2121478697154;2436.8294219404647;2463.5811911975006;2504.4114633061217;2541.936451588725;10374.118199953013;11554.133439992034;12418.875811241862;13474.52839150625;14162.92918535411;1926.3835572616767;1935.4097000414868;1955.286320493024;1972.142118178597;2032.6849338352579;63252;65422;65803;66236.66881665561;67800.3219967799;10455.581776728846;10472.947635261775;10487.632932847466;10623.150147988143;10817.83773243402;13686.93156534231;13702.45190192401;13721.519746808814;13745.38145783422;13761.724765504634;8141.959290203511;8321.6671333146;8366.748997530083;8411.70559030431;8568.314534837198;8633.91366086331;8670.609822558;8691.217790398894;8738.475691458405;8755.255803256794;4325.567443255649;4593.402857628487;4666.533346665306;4700.412448443944;4744.620430365562;1794.605186858889;1833.9215754601005;1930.2375561653068;1949.1228946973918;1960.607878424321;819.5861090149436;884.5842454046588;886.8403687336213;910.5765818894246;947.976300592477;15172.468963586442;17525.386611468537;17652.91173544124;17768.555786105193;18937.526561835788;1043.5512729526376;1051.3429106808244;1087.532361084741;1091.8908109189017;1104.7956128116325;10249.692509224735;10378.221633377376;10461.633842815465;10472.319299245524;10493.26547141708;695236;712118;714491;725731;729421;83145.58427207825;83156.58421707853;85239.57380213059;85332;85837;1253.0414233111676;1255.428779905141;1262.9684257893625;1264.0835394339215;1272.516443751387;15548.222588870285;15930.362785488915;16277.837221628106;16480.587985300463;16570.254338554554;33714;34238.315233695685;34301.48547771735;34980.82509587436;36926;46738.065238695715;47407;48965.510344896094;49111.26333104935;52721.20918186307;10398.168146548107;10467.685969420625;10534.420606866695;10592.099671528007;10661.946690266499;11949.103817213918;12032.75934481288;12133.635990920286;16652.58368540796;19159.137838797567;15449.922750386626;15738.685226295182;15875.126868021907;15974.920125399298;16281.837181628032;12053.63839084829;14877.776833347292;15742.763858541903;15883.364665413254;16243.51269461918;14626.049306795025;14809.777853331992;14930.701385972003;14935.17856517902;15027.323770430576;9854.753631159278;10320.793584128125;10410.68767936963;10411.11505522039;10464.790704185722;14963.102213867203;15043.247837608295;15431.459898903484;15531.301091451138;16027.519174424786 10:08:12 INFO - 2016-02-08 10:08:12,825 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1550.7673848922661;1617.2479796894445;1623.886327957042;1814.5282226621082;1918.3957053528138;7999;8262.586870656465;8263.710770123047;8265.132161123085;8266.50400975942;7480.251974802517;7657.042869641295;8048.195180481949;8254.669813207465;8291.046529649093;2352.2590384029063;2369.490559529701;2380.1907351500486;2388.7133543974746;2391.175044609607;2189.5839790439845;2429.149797570854;2441.56051910656;2489.116363690891;2491.713452952906;2124.468882779305;2335.509542995973;2361.7756313150308;2374.6912901322803;2377.8573285602833;2317.4553979814814;2334.9299521014395;2346.8122550195944;2379.5240951809533;2380.8928598213124;2369.04053858186;2371.0634299451795;2389.952200955971;2404.699412573428;2415.6014257647466;8419.621117049748;8481.194286542768;8487.533185674785;8498.277646400064;8504;5019.698818070891;5099.923501147486;5118.897622047538;5135.332406787131;5137.8201762938115;3229.4994275887275;3237.5629290045777;3277.7869438486423;3312.5031245313153;3336.282699219655;979.9559019844124;995.5420506566987;1012.7012531303283;1023.488255872064;1039.0544604410027;11894.226875253082;11903.88096119045;11908.821367679491;11914.523419063227;11915.761684766343;4585.908281834345;4600.95399046012;4624.97687511567;4662.7668616569035;4663.533646635309;10140.442275674908;10182.490875456198;10196.643117490852;10199.18406527476;10212.336198147097;5177.896442071137;5206.140986737221;5207.739613019334;5211.4527974562125;5216.061109000417;4683.95316046842;4716.787744551435;4717.268823332389;4718.551737584924;4724.314974328772;3828.617138286149;3843.6925045996254;3866.1881004988704;3885.1646895917515;3885.572587015426;1242.1180961517423;1262.2300396757971;1272.917260378091;1286.5304163980268;1299.7725398055302;1196.617082533581;1221.9816702749465;1222.3582619124852;1365.8224430824127;1382.4884792626592;8084.070331911906;8114.310283625958;8222.095569487352;8239.546824924566;8246.09292977772;1196.8264601632889;1203.8796120388067;1204.9156559040957;1238.2817965579943;1241.1498123785236;6370.394812492806;6382.521310901701;6429.967850160813;6432.163818703539;6437.0988061671405;10053.693019907512;10307.330023548595;10325.173986081245;10431.791364172674;10438.425886576311;9951.950240248752;10107.191424686154;10224.846627300596;10229.48852557384;10264.973502649675;8014;8099.14958929304;8103.635336409876;8108.5540295283145;8119.188081191952;7953.562554059582;7991.041075071029;8015.83968320642;8062.55655938929;8092;8918.910810892068;8975.955120224357;9057.77355566116;9110.271178305587;9124.635014599342;9032.45805251687;9237.03011183816;9256.305777066882;9422.199113075465;9449.338546301968;7733.110692270461;7738.2261773822165;7811.414143939113;7829.138794732461;7829.804254893445;8376.958115209385;8421.70524031656;8442.240198382175;8446.239838414573;8451;6714.52998290115;7813.609319534115;7844.294013538809;7921.485103468256;8070.596470176585;7694.461387703031;7698;7728.227177282227;7800.102988156208;7810.570418626803;7586.241375862591;7621.542707437349;7635.045619297588;7637.732679356196;7650;6723.394894459522;6869.072675188786;6875.278095799869;7157.821054473679;7255.854882902207;7110.146782386147;7115;7152.284771522806;7173.10336207974;7187 10:08:12 INFO - 2016-02-08 10:08:12,825 DEBUG : BROWSER_OUTPUT: |4;prototype.html;351.33948177426436;356.9696575791058;357.30504169390537;363.53104495201194;365.57410616631626;5838.854028649275;5917.585768996172;5973.850653733659;5984.850378740533;6021.187139736135;5801.709914504268;5926.733297001634;5936;5939.287285525743;5954.4938680212235;4661.720296782187;4672.4393072831135;4675.345451636774;4676.532346765313;4683.555062269079;4669.369635099269;4679.15775160471;4683.531646835323;4684.5315468453055;4686.90626187476;4550.749708766017;4636.09596128755;4640.582347588716;4642.535746425364;4649.488556258809;4625.051864367797;4630.166570017395;4636.374089497908;4643.0017546227555;4648.1168577970075;3833.1758671885677;4116.197341518405;4117.75293482389;4118.732282401635;4128.215639028605;5512.614117011811;5525.557955363562;5646.265985421869;5666.575006874501;5670.489655930986;5343.225232341289;5344.91982620261;5368.033753924292;5380.838574842722;5388.110961691316;6297.464715499188;6312.053192021233;6319.052142178664;6322.810315690536;6325.209348831396;4455.799489022969;4540.682152249344;4540.682152249344;4540.909181816378;4551.180787458256;6536.673166341664;6536.803895883084;6539.47684185264;6541.345865413468;6545.37818907203;4669.322948172564;4673.60274376675;4674.439067311944;4676.69601475903;4676.929846052312;4629.65277604181;4733.597644200281;4734.455537613149;4735.573798358164;4736.384270044872;5324.946750532523;5335.839924802262;5338.54622357104;5338.946610533845;5338.9466105339225;6312.368763123651;6328.810135695937;6330.715117819709;6332.620042797447;6338.619682819046;1641.1302009934755;1655.2964989879254;1662.950111496657;1663.2432243329256;1663.2931004323113;1143.3482914738686;1145.633397312852;1146.9713257168637;1163.313644949467;1173.208084542947;6169.629822210682;6177;6178.7219575119225;6180.938190618126;6181.690915454209;6512.446442052384;6512.8602494563265;6520.250171230275;6523.347665233438;6528.673566321665;6073.878522429615;6212.0371342441995;6212.596181248205;6215.533834962305;6221.440070393686;3456.948145777815;3483.1814523586936;3483.6168021517615;3489.354469423165;3520.2255503789124;6614.305497922745;6711.429528490133;6736;6800.047993280945;6901.515454436399;6702.061711360413;6730.9326906731285;6765;6767.052612634235;6768;6824.283450237753;6829.897551536731;6870.931290687129;6872.381485666314;6878.828029299308;6401.615903045832;6583.572067815577;6590.670466476753;6590.736370545124;6594.769183078569;6506.967465162644;6507.023946408077;6513.2835388108215;6516.478681705547;6517.3808488193545;6862.725490980305;6868.450523957971;6874.278200788845;6875.243723190345;6881.552699074544;4461.843835465743;4584.564466375689;4600.378948841997;4600.470945841137;4602.4477062752685;6549.7380104795275;6554.279029306867;6555.96722016406;6556.311587283267;6560.967195163994;6333.714982825692;6371.980483122678;6387.690523442776;6392.105105285357;6403.103565500741;6259.624422534663;6384.329645387354;6386.233651961795;6389.808305750835;6397.776077837253;6290.905636415366;6304.71628776697;6307.558470906993;6311.400416960381;6314.778982735582;6387.201599800025;6394.1687580614225;6394.968025159845;6395.584287021329;6403.29563747978;6144.262688477412;6252;6257.2804127525915;6262.686865656608;6269.122322874892 10:08:12 INFO - 2016-02-08 10:08:12,826 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.577282494628;798.4131663227527;821.6261600971558;883.1565854608849;978.349397650562;14626.780598291021;14649.853501464982;14766.114033158017;14780.852191478081;14789.408423663053;14062.367193476293;14075.155490670568;14087.788683169761;14142.717145657081;14143.009989300754;735.6542425060213;746.4028776978423;867.8307729992654;889.208604342136;903.1465265324272;891.4205766251923;895.6238379880433;900.0189793125492;900.2572877376158;901.0223907060814;941.7786820097272;945.0927109974433;945.6170251048336;953.3326671330062;953.7806304549957;781.7107670162048;786.0724345272577;934.4159900062461;947.2895328503622;951.7477868364889;702.0978043214445;704.9506534542584;705.1538154214911;706.1138271469273;708.2032713197652;14107.929460352736;14171.78742318866;14221.21783301918;14226.075305105238;14226.857731422657;12105.515779368814;12765.55320563785;13294.20234785916;13655.795163072562;14101.506447274398;11450.713732156679;11981.041516678732;12136.211146275464;12261.570845020382;12439.937800310941;3935.311320518898;3957.426173204898;4025.376066709665;4194.790260486963;4195.769232692201;48940;49116.508834911554;50329.24506132411;50423.243651345256;51051.48948510542;10262.332948358333;10371.429571373495;10478.056974872297;10660.520276587573;10683.893161068445;19162.04189790505;19343.613127737648;19378.70931936022;19390.12744426476;19404;8131.674733010614;8221.424500285042;8471.279941204943;8551.358648101417;8618.482891026559;4597.057603191338;4598.908021839545;4649.465311489154;4755.9286610700865;4800.879978000578;3388.15296175956;3415.026717385533;3438.3639026780124;3442.087846720621;3444.293919746446;598.2103623217398;616.5899676714935;622.3061286665336;633.0441034038635;636.1793286660156;726.851989201062;732.4835990626596;738.4018944654847;740.1007775552729;746.3320328306136;8858.15847494487;9043.68347107848;9062.773430664287;9069.727908162766;9231;724.9855002899913;755.7732680196029;759.9050118735158;761.1779278379337;769.4959801330137;4199.118185181085;4333.15503476819;4429.136318417877;4500.819967201341;4535.705179163344;59156.40843591595;60537.09194362088;60930.69534652387;60946.39053609496;61074;53576.196357053894;54951.17573236405;54987.45012549823;55388.44611553913;55447.44552554504;48429.27356089662;48476.7576162117;48814.02371952541;48965;49464.25803612949;8747.300215982834;8810.251128654136;8818.162274583905;9049.638014479347;9146;37073.629263707015;37701.434478483396;38572.22855542817;38574.6142538571;38575.22849542937;43545.12909741851;43808.56191438045;45574.31638525359;48757.268640971124;48835.26747098725;11529.250598711056;11632.709182270512;11901.285922844658;11972.700682482659;12036.976856966905;12835.165714228546;12894.742105158031;13167.53913613019;13435.798463023259;13806.318331744787;11597.246178998337;11771.47028383742;12010.219335743148;12044.638660840188;12183.878161218629;11288.59751629069;11743.47154378072;11782.52869885195;12018.63944081644;12161.33112678811;11527.711807204887;11967.222130561486;12062.577809776616;12127.090468214743;12129.575464858688;10398.428086455318;10630.84053739179;10649.307794993301;10937.890621094006;11317.547298108313;9387.436753794795;9733.9026609733;9885.357451765612;9977.151942085004;10003.499825008575 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,761 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1454954892819__endTimestamp 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:08:12 INFO - 2016-02-08 10:08:12,827 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:08:12 INFO - 2016-02-08 10:08:12,828 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,828 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5474.11 Median:5672.66 stddev:598.49 (10.6%) stddev-sans-first:574.97 10:08:12 INFO - 2016-02-08 10:08:12,828 DEBUG : BROWSER_OUTPUT: Values: 3276.8 3330.3 3354.3 3367.0 3374.3 5454.3 5472.6 5487.3 5509.0 5511.1 5456.8 5471.6 5480.9 5496.9 5508.1 4844.1 5000.3 5045.7 5069.2 5101.1 5014.2 5082.6 5084.2 5086.0 5087.3 4929.9 5003.9 5015.9 5026.3 5054.2 5045.2 5142.9 5147.1 5147.8 5171.4 4771.7 5052.0 5057.9 5077.0 5123.5 5269.9 5281.3 5299.4 5327.3 5340.2 5875.0 5925.1 5928.5 5930.4 5938.6 5774.6 5849.4 5909.1 5939.0 5940.1 5426.8 5497.1 5521.9 5523.7 5527.5 6012.2 6020.1 6021.5 6067.5 6078.0 5527.9 5683.8 5727.7 5828.9 5848.9 5955.8 5980.0 5989.2 5993.7 6003.9 5901.1 5939.5 5944.8 5949.3 5956.9 5668.5 5760.3 5935.5 5937.0 5939.8 4462.0 4528.4 4528.9 4543.5 4553.0 4057.3 4060.7 4063.6 4081.6 4097.0 5350.5 5493.5 5634.1 5635.9 5638.3 5807.2 5883.1 5890.1 5902.6 5922.7 5514.2 5520.2 5526.3 5535.2 5542.4 4931.8 5001.8 5013.4 5080.6 5116.5 6091.7 6104.0 6105.5 6106.9 6108.9 5923.2 5930.4 5946.9 5951.9 5955.0 5876.5 5935.5 5986.4 6048.8 6139.4 5784.1 5786.2 5787.1 5787.5 5788.6 5815.4 5843.2 5853.1 5857.1 5857.9 5509.7 5667.0 5704.4 5790.3 5811.7 5760.9 5793.8 5799.9 5801.1 5802.6 5451.1 5725.4 5733.7 5736.6 5737.5 5631.4 5839.9 5907.8 5940.8 5977.3 5665.7 5672.7 5677.2 5685.5 5687.6 10:08:12 INFO - 2016-02-08 10:08:12,828 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,828 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50574.61 Median:189564.57 stddev:83049.33 (43.8%) stddev-sans-first:83197.65 10:08:12 INFO - 2016-02-08 10:08:12,830 DEBUG : BROWSER_OUTPUT: Values: 633.9 638.0 638.6 646.6 652.5 40828.4 41973.6 42030.2 42030.6 42065.2 46355.1 46877.0 46966.0 47009.0 47040.3 8034.2 8121.3 9085.7 9272.9 10439.9 10626.5 10738.5 10739.7 10747.1 10750.6 10782.5 10851.0 10857.6 10933.2 10944.0 8209.4 8404.9 10958.3 11203.2 11208.4 10545.2 10684.2 10684.5 10685.3 10698.1 42184.4 42431.0 42557.7 42694.8 42704.4 3682.6 3803.3 4083.1 4150.5 4259.1 32182.5 32620.0 32688.2 33025.2 33182.5 4304.4 4323.6 4368.7 4374.2 4400.9 276678.0 277247.0 277544.0 278120.0 278366.0 58191.1 59085.7 67877.0 68316.0 68328.0 78709.2 79810.2 80102.6 80134.6 80226.0 16408.0 16744.2 16745.6 16756.2 16783.0 12890.5 12985.9 13000.5 13019.9 13023.5 21871.5 22146.4 22240.2 22278.7 22314.4 8124.4 8156.0 8268.6 8340.3 8377.2 1074.2 1079.7 1117.8 1140.7 1200.9 30263.7 30430.2 30465.0 30565.8 31211.5 1133.7 1209.6 1219.5 1225.2 1228.4 13816.9 15806.8 16004.8 16086.8 16681.5 337208.0 343590.0 343654.0 344633.7 344646.0 57354.0 57502.4 57648.7 57687.0 57787.7 1448.5 1454.8 1462.3 1465.3 1474.9 31462.1 31465.5 31785.5 31858.8 31972.8 51735.2 51864.5 52443.0 52468.5 52481.2 326934.0 329079.0 329177.0 329233.0 329968.0 30875.4 31155.5 34561.3 34625.3 35128.0 40064.6 40678.2 40680.6 40987.8 41807.4 34123.0 34636.0 34803.0 34950.7 35199.5 32821.5 37780.0 38067.5 42445.6 42775.1 36940.3 37182.6 37884.0 37923.6 38118.0 32390.5 34509.0 34749.4 35052.1 35092.5 26468.7 27023.6 34483.1 34741.3 36974.0 10:08:12 INFO - 2016-02-08 10:08:12,830 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,830 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34423.94 Median:1928.31 stddev:116768.73 (6055.5%) stddev-sans-first:117068.31 10:08:12 INFO - 2016-02-08 10:08:12,830 DEBUG : BROWSER_OUTPUT: Values: 382.1 384.8 387.2 390.6 394.9 15354.4 15490.0 16692.2 18077.5 18085.8 17996.3 18044.8 18338.5 18363.4 18370.5 6033.9 6155.6 6157.4 6162.5 6170.4 4630.1 4744.3 6030.2 6795.8 6988.5 5459.6 6897.1 6916.4 6921.9 6958.3 5582.6 5600.4 5604.0 5604.6 5605.0 5318.4 5407.3 5408.9 5416.1 5437.8 13929.9 14110.4 14120.7 18486.7 22683.7 2317.2 2436.8 2463.6 2504.4 2541.9 10374.1 11554.1 12418.9 13474.5 14162.9 1926.4 1935.4 1955.3 1972.1 2032.7 63252.0 65422.0 65803.0 66236.7 67800.3 10455.6 10472.9 10487.6 10623.2 10817.8 13686.9 13702.5 13721.5 13745.4 13761.7 8142.0 8321.7 8366.7 8411.7 8568.3 8633.9 8670.6 8691.2 8738.5 8755.3 4325.6 4593.4 4666.5 4700.4 4744.6 1794.6 1833.9 1930.2 1949.1 1960.6 819.6 884.6 886.8 910.6 948.0 15172.5 17525.4 17652.9 17768.6 18937.5 1043.6 1051.3 1087.5 1091.9 1104.8 10249.7 10378.2 10461.6 10472.3 10493.3 695236.0 712118.0 714491.0 725731.0 729421.0 83145.6 83156.6 85239.6 85332.0 85837.0 1253.0 1255.4 1263.0 1264.1 1272.5 15548.2 15930.4 16277.8 16480.6 16570.3 33714.0 34238.3 34301.5 34980.8 36926.0 46738.1 47407.0 48965.5 49111.3 52721.2 10398.2 10467.7 10534.4 10592.1 10661.9 11949.1 12032.8 12133.6 16652.6 19159.1 15449.9 15738.7 15875.1 15974.9 16281.8 12053.6 14877.8 15742.8 15883.4 16243.5 14626.0 14809.8 14930.7 14935.2 15027.3 9854.8 10320.8 10410.7 10411.1 10464.8 14963.1 15043.2 15431.5 15531.3 16027.5 10:08:12 INFO - 2016-02-08 10:08:12,831 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,831 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5964.24 Median:5136.58 stddev:3129.32 (60.9%) stddev-sans-first:3120.51 10:08:12 INFO - 2016-02-08 10:08:12,832 DEBUG : BROWSER_OUTPUT: Values: 1550.8 1617.2 1623.9 1814.5 1918.4 7999.0 8262.6 8263.7 8265.1 8266.5 7480.3 7657.0 8048.2 8254.7 8291.0 2352.3 2369.5 2380.2 2388.7 2391.2 2189.6 2429.1 2441.6 2489.1 2491.7 2124.5 2335.5 2361.8 2374.7 2377.9 2317.5 2334.9 2346.8 2379.5 2380.9 2369.0 2371.1 2390.0 2404.7 2415.6 8419.6 8481.2 8487.5 8498.3 8504.0 5019.7 5099.9 5118.9 5135.3 5137.8 3229.5 3237.6 3277.8 3312.5 3336.3 980.0 995.5 1012.7 1023.5 1039.1 11894.2 11903.9 11908.8 11914.5 11915.8 4585.9 4601.0 4625.0 4662.8 4663.5 10140.4 10182.5 10196.6 10199.2 10212.3 5177.9 5206.1 5207.7 5211.5 5216.1 4684.0 4716.8 4717.3 4718.6 4724.3 3828.6 3843.7 3866.2 3885.2 3885.6 1242.1 1262.2 1272.9 1286.5 1299.8 1196.6 1222.0 1222.4 1365.8 1382.5 8084.1 8114.3 8222.1 8239.5 8246.1 1196.8 1203.9 1204.9 1238.3 1241.1 6370.4 6382.5 6430.0 6432.2 6437.1 10053.7 10307.3 10325.2 10431.8 10438.4 9952.0 10107.2 10224.8 10229.5 10265.0 8014.0 8099.1 8103.6 8108.6 8119.2 7953.6 7991.0 8015.8 8062.6 8092.0 8918.9 8976.0 9057.8 9110.3 9124.6 9032.5 9237.0 9256.3 9422.2 9449.3 7733.1 7738.2 7811.4 7829.1 7829.8 8377.0 8421.7 8442.2 8446.2 8451.0 6714.5 7813.6 7844.3 7921.5 8070.6 7694.5 7698.0 7728.2 7800.1 7810.6 7586.2 7621.5 7635.0 7637.7 7650.0 6723.4 6869.1 6875.3 7157.8 7255.9 7110.1 7115.0 7152.3 7173.1 7187.0 10:08:12 INFO - 2016-02-08 10:08:12,833 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,833 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5349.36 Median:6109.07 stddev:1584.24 (25.9%) stddev-sans-first:1543.63 10:08:12 INFO - 2016-02-08 10:08:12,834 DEBUG : BROWSER_OUTPUT: Values: 351.3 357.0 357.3 363.5 365.6 5838.9 5917.6 5973.9 5984.9 6021.2 5801.7 5926.7 5936.0 5939.3 5954.5 4661.7 4672.4 4675.3 4676.5 4683.6 4669.4 4679.2 4683.5 4684.5 4686.9 4550.7 4636.1 4640.6 4642.5 4649.5 4625.1 4630.2 4636.4 4643.0 4648.1 3833.2 4116.2 4117.8 4118.7 4128.2 5512.6 5525.6 5646.3 5666.6 5670.5 5343.2 5344.9 5368.0 5380.8 5388.1 6297.5 6312.1 6319.1 6322.8 6325.2 4455.8 4540.7 4540.7 4540.9 4551.2 6536.7 6536.8 6539.5 6541.3 6545.4 4669.3 4673.6 4674.4 4676.7 4676.9 4629.7 4733.6 4734.5 4735.6 4736.4 5324.9 5335.8 5338.5 5338.9 5338.9 6312.4 6328.8 6330.7 6332.6 6338.6 1641.1 1655.3 1663.0 1663.2 1663.3 1143.3 1145.6 1147.0 1163.3 1173.2 6169.6 6177.0 6178.7 6180.9 6181.7 6512.4 6512.9 6520.3 6523.3 6528.7 6073.9 6212.0 6212.6 6215.5 6221.4 3456.9 3483.2 3483.6 3489.4 3520.2 6614.3 6711.4 6736.0 6800.0 6901.5 6702.1 6730.9 6765.0 6767.1 6768.0 6824.3 6829.9 6870.9 6872.4 6878.8 6401.6 6583.6 6590.7 6590.7 6594.8 6507.0 6507.0 6513.3 6516.5 6517.4 6862.7 6868.5 6874.3 6875.2 6881.6 4461.8 4584.6 4600.4 4600.5 4602.4 6549.7 6554.3 6556.0 6556.3 6561.0 6333.7 6372.0 6387.7 6392.1 6403.1 6259.6 6384.3 6386.2 6389.8 6397.8 6290.9 6304.7 6307.6 6311.4 6314.8 6387.2 6394.2 6395.0 6395.6 6403.3 6144.3 6252.0 6257.3 6262.7 6269.1 10:08:12 INFO - 2016-02-08 10:08:12,835 DEBUG : BROWSER_OUTPUT: 10:08:12 INFO - 2016-02-08 10:08:12,835 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14665.31 Median:4624.19 stddev:16778.32 (362.8%) stddev-sans-first:16792.93 10:08:12 INFO - 2016-02-08 10:08:12,835 DEBUG : BROWSER_OUTPUT: Values: 768.6 798.4 821.6 883.2 978.3 14626.8 14649.9 14766.1 14780.9 14789.4 14062.4 14075.2 14087.8 14142.7 14143.0 735.7 746.4 867.8 889.2 903.1 891.4 895.6 900.0 900.3 901.0 941.8 945.1 945.6 953.3 953.8 781.7 786.1 934.4 947.3 951.7 702.1 705.0 705.2 706.1 708.2 14107.9 14171.8 14221.2 14226.1 14226.9 12105.5 12765.6 13294.2 13655.8 14101.5 11450.7 11981.0 12136.2 12261.6 12439.9 3935.3 3957.4 4025.4 4194.8 4195.8 48940.0 49116.5 50329.2 50423.2 51051.5 10262.3 10371.4 10478.1 10660.5 10683.9 19162.0 19343.6 19378.7 19390.1 19404.0 8131.7 8221.4 8471.3 8551.4 8618.5 4597.1 4598.9 4649.5 4755.9 4800.9 3388.2 3415.0 3438.4 3442.1 3444.3 598.2 616.6 622.3 633.0 636.2 726.9 732.5 738.4 740.1 746.3 8858.2 9043.7 9062.8 9069.7 9231.0 725.0 755.8 759.9 761.2 769.5 4199.1 4333.2 4429.1 4500.8 4535.7 59156.4 60537.1 60930.7 60946.4 61074.0 53576.2 54951.2 54987.5 55388.4 55447.4 48429.3 48476.8 48814.0 48965.0 49464.3 8747.3 8810.3 8818.2 9049.6 9146.0 37073.6 37701.4 38572.2 38574.6 38575.2 43545.1 43808.6 45574.3 48757.3 48835.3 11529.3 11632.7 11901.3 11972.7 12037.0 12835.2 12894.7 13167.5 13435.8 13806.3 11597.2 11771.5 12010.2 12044.6 12183.9 11288.6 11743.5 11782.5 12018.6 12161.3 11527.7 11967.2 12062.6 12127.1 12129.6 10398.4 10630.8 10649.3 10937.9 11317.5 9387.4 9733.9 9885.4 9977.2 10003.5 10:08:12 INFO - 2016-02-08 10:08:12,835 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:08:12 INFO - 2016-02-08 10:08:12,836 DEBUG : BROWSER_OUTPUT: 10:08:13 INFO - 2016-02-08 10:08:13,469 INFO : Browser exited with error code: 0 10:08:13 INFO - 2016-02-08 10:08:13,492 INFO : Completed test dromaeo_css (00:18:32) 10:08:13 INFO - 2016-02-08 10:08:13,492 INFO : Starting test kraken 10:08:13 INFO - 2016-02-08 10:08:13,492 DEBUG : operating with platform_type : linux_ 10:08:13 INFO - 2016-02-08 10:08:13,493 INFO : Initialising browser for kraken test... 10:08:13 INFO - 2016-02-08 10:08:13,499 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbzWvpP/profile http://localhost:53362/getInfo.html 10:08:18 INFO - 2016-02-08 10:08:18,676 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:08:18 INFO - 2016-02-08 10:08:18,677 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:08:18 INFO - 2016-02-08 10:08:18,677 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:08:18 INFO - 2016-02-08 10:08:18,677 DEBUG : BROWSER_OUTPUT: __metrics 10:08:18 INFO - 2016-02-08 10:08:18,946 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:08:20 INFO - 2016-02-08 10:08:20,220 INFO : Browser initialized. 10:08:20 INFO - 2016-02-08 10:08:20,220 INFO : Running cycle 1/1 for kraken test... 10:08:20 INFO - 2016-02-08 10:08:20,220 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbzWvpP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:08:32 INFO - 2016-02-08 10:08:32,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 135008256 10:08:32 INFO - 2016-02-08 10:08:32,008 DEBUG : BROWSER_OUTPUT: 10:08:34 INFO - 2016-02-08 10:08:34,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53362/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:35 INFO - 2016-02-08 10:08:35,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 165851136 10:08:35 INFO - 2016-02-08 10:08:35,010 DEBUG : BROWSER_OUTPUT: 10:08:37 INFO - 2016-02-08 10:08:37,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53362/tests/kraken/driver.html?testName=audio-dft) 10:08:38 INFO - 2016-02-08 10:08:38,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 163713024 10:08:38 INFO - 2016-02-08 10:08:38,113 DEBUG : BROWSER_OUTPUT: 10:08:40 INFO - 2016-02-08 10:08:40,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53362/tests/kraken/driver.html?testName=audio-fft) 10:08:41 INFO - 2016-02-08 10:08:41,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 160882688 10:08:41 INFO - 2016-02-08 10:08:41,450 DEBUG : BROWSER_OUTPUT: 10:08:43 INFO - 2016-02-08 10:08:43,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53362/tests/kraken/driver.html?testName=audio-oscillator) 10:08:44 INFO - 2016-02-08 10:08:44,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 161820672 10:08:44 INFO - 2016-02-08 10:08:44,002 DEBUG : BROWSER_OUTPUT: 10:08:46 INFO - 2016-02-08 10:08:46,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:46 INFO - 2016-02-08 10:08:46,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 160276480 10:08:46 INFO - 2016-02-08 10:08:46,714 DEBUG : BROWSER_OUTPUT: 10:08:49 INFO - 2016-02-08 10:08:49,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53362/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:50 INFO - 2016-02-08 10:08:50,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 161185792 10:08:50 INFO - 2016-02-08 10:08:50,131 DEBUG : BROWSER_OUTPUT: 10:08:53 INFO - 2016-02-08 10:08:53,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53362/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:54 INFO - 2016-02-08 10:08:54,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 159358976 10:08:54 INFO - 2016-02-08 10:08:54,068 DEBUG : BROWSER_OUTPUT: 10:08:56 INFO - 2016-02-08 10:08:56,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53362/tests/kraken/driver.html?testName=json-parse-financial) 10:08:57 INFO - 2016-02-08 10:08:57,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 159125504 10:08:57 INFO - 2016-02-08 10:08:57,305 DEBUG : BROWSER_OUTPUT: 10:08:58 INFO - 2016-02-08 10:08:58,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:59 INFO - 2016-02-08 10:08:59,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 166670336 10:08:59 INFO - 2016-02-08 10:08:59,414 DEBUG : BROWSER_OUTPUT: 10:09:01 INFO - 2016-02-08 10:09:01,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:01 INFO - 2016-02-08 10:09:01,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 165478400 10:09:01 INFO - 2016-02-08 10:09:01,735 DEBUG : BROWSER_OUTPUT: 10:09:03 INFO - 2016-02-08 10:09:03,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:04 INFO - 2016-02-08 10:09:04,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 168787968 10:09:04 INFO - 2016-02-08 10:09:04,257 DEBUG : BROWSER_OUTPUT: 10:09:06 INFO - 2016-02-08 10:09:06,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:07 INFO - 2016-02-08 10:09:07,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 174944256 10:09:07 INFO - 2016-02-08 10:09:07,201 DEBUG : BROWSER_OUTPUT: 10:09:09 INFO - 2016-02-08 10:09:09,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:10 INFO - 2016-02-08 10:09:10,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 172457984 10:09:10 INFO - 2016-02-08 10:09:10,211 DEBUG : BROWSER_OUTPUT: 10:09:11 INFO - 2016-02-08 10:09:11,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53362/tests/kraken/driver.html?testName=ai-astar) 10:09:12 INFO - 2016-02-08 10:09:12,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 231071744 10:09:12 INFO - 2016-02-08 10:09:12,103 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,104 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:09:12 INFO - 2016-02-08 10:09:12,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:09:12 INFO - 2016-02-08 10:09:12,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:09:12 INFO - 2016-02-08 10:09:12,104 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;109;111;109;99;109;109;110 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;120;145;152;123;148;154;122;162;123 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;158;159;159;159;160;162;159;161 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;77;72;155;72;72;71;73;162;73 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;136;92;93;93;140;92;93;133 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;108;109;109;109;109;110;109;109;110 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;145;146;145;146;145;145 10:09:12 INFO - 2016-02-08 10:09:12,105 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 10:09:12 INFO - 2016-02-08 10:09:12,106 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;58;58;57;56;56;57;57;55 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;63;64;64;63;64;64;63 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;81;78;79;86;77;78;78;77 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;115;127;113;114;126;122;110;114;115 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;142;144;134;141;135;140;142;140;131 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;65;64;64;66;64;63;64;63 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,869 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: __startTimestamp1454954952103__endTimestamp 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,107 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:09:12 INFO - 2016-02-08 10:09:12,108 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.61 (3.3%) stddev-sans-first:3.83 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 109.0 111.0 109.0 99.0 109.0 109.0 110.0 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.50 stddev:15.85 (10.7%) stddev-sans-first:16.59 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: Values: 147.0 120.0 145.0 152.0 123.0 148.0 154.0 122.0 162.0 123.0 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.50 Median:159.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 158.0 159.0 159.0 159.0 160.0 162.0 159.0 161.0 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.80 Median:72.00 stddev:36.29 (50.4%) stddev-sans-first:37.84 10:09:12 INFO - 2016-02-08 10:09:12,109 DEBUG : BROWSER_OUTPUT: Values: 71.0 77.0 72.0 155.0 72.0 72.0 71.0 73.0 162.0 73.0 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:93.00 stddev:21.14 (22.7%) stddev-sans-first:21.91 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 136.0 92.0 93.0 93.0 140.0 92.0 93.0 133.0 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 10:09:12 INFO - 2016-02-08 10:09:12,110 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 58.0 58.0 57.0 56.0 56.0 57.0 57.0 55.0 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 63.0 64.0 64.0 63.0 64.0 64.0 63.0 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.82 (3.6%) stddev-sans-first:2.92 10:09:12 INFO - 2016-02-08 10:09:12,111 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 81.0 78.0 79.0 86.0 77.0 78.0 78.0 77.0 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:115.00 stddev:5.78 (5.0%) stddev-sans-first:6.08 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: Values: 115.0 115.0 127.0 113.0 114.0 126.0 122.0 110.0 114.0 115.0 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:140.50 stddev:4.81 (3.4%) stddev-sans-first:4.38 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: Values: 131.0 142.0 144.0 134.0 141.0 135.0 140.0 142.0 140.0 131.0 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 10:09:12 INFO - 2016-02-08 10:09:12,112 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 65.0 64.0 64.0 66.0 64.0 63.0 64.0 63.0 10:09:12 INFO - 2016-02-08 10:09:12,113 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:09:12 INFO - 2016-02-08 10:09:12,113 DEBUG : BROWSER_OUTPUT: 10:09:12 INFO - 2016-02-08 10:09:12,825 INFO : Browser exited with error code: 0 10:09:12 INFO - 2016-02-08 10:09:12,875 INFO : Completed test kraken (00:00:59) 10:09:12 INFO - 2016-02-08 10:09:12,875 INFO : Starting test v8_7 10:09:12 INFO - 2016-02-08 10:09:12,876 DEBUG : operating with platform_type : linux_ 10:09:12 INFO - 2016-02-08 10:09:12,876 INFO : Initialising browser for v8_7 test... 10:09:12 INFO - 2016-02-08 10:09:12,882 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplYwnRK/profile http://localhost:53362/getInfo.html 10:09:17 INFO - 2016-02-08 10:09:17,935 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:09:17 INFO - 2016-02-08 10:09:17,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:09:17 INFO - 2016-02-08 10:09:17,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:09:17 INFO - 2016-02-08 10:09:17,936 DEBUG : BROWSER_OUTPUT: __metrics 10:09:18 INFO - 2016-02-08 10:09:18,227 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:09:19 INFO - 2016-02-08 10:09:19,754 INFO : Browser initialized. 10:09:19 INFO - 2016-02-08 10:09:19,755 INFO : Running cycle 1/1 for v8_7 test... 10:09:19 INFO - 2016-02-08 10:09:19,755 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplYwnRK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:09:31 INFO - 2016-02-08 10:09:31,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 135180288 10:09:31 INFO - 2016-02-08 10:09:31,560 DEBUG : BROWSER_OUTPUT: 10:09:52 INFO - 2016-02-08 10:09:52,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53362/tests/v8_7/run.html (next: http://localhost:53362/tests/v8_7/run.html) 10:09:53 INFO - 2016-02-08 10:09:53,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 425529344 10:09:53 INFO - 2016-02-08 10:09:53,188 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,188 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:09:53 INFO - 2016-02-08 10:09:53,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:09:53 INFO - 2016-02-08 10:09:53,188 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |0;Richards;165.01650165016503 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.9986320109439 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |5;Earley;543.773790103317 10:09:53 INFO - 2016-02-08 10:09:53,189 DEBUG : BROWSER_OUTPUT: |6;Boyer;10547.368421052632 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: |7;RegExp;24333.333333333332 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: |8;Splay;524.8821372446307 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: __startTimestamp1454954993181__endTimestamp 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,190 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: Values: 165.0 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.00 Median:171.00 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,191 DEBUG : BROWSER_OUTPUT: Values: 171.0 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: Values: 278.3 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: Values: 5133.3 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,192 DEBUG : BROWSER_OUTPUT: Values: 948.8 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.77 Median:543.77 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: Values: 543.8 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10547.37 Median:10547.37 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: Values: 10547.4 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24333.33 Median:24333.33 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: Values: 24333.3 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.88 Median:524.88 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: Values: 524.9 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:09:53 INFO - 2016-02-08 10:09:53,193 DEBUG : BROWSER_OUTPUT: 10:09:53 INFO - 2016-02-08 10:09:53,949 INFO : Browser exited with error code: 0 10:09:53 INFO - 2016-02-08 10:09:53,963 INFO : Completed test v8_7 (00:00:41) 10:09:54 INFO - 2016-02-08 10:09:54,228 INFO : Completed test suite (00:20:13) 10:09:54 INFO - 2016-02-08 10:09:54,229 DEBUG : Working with test: dromaeo_css 10:09:54 INFO - 2016-02-08 10:09:54,229 DEBUG : Generating results file: dromaeo_css 10:09:54 INFO - 2016-02-08 10:09:54,230 DEBUG : Working with test: kraken 10:09:54 INFO - 2016-02-08 10:09:54,230 DEBUG : Generating results file: kraken 10:09:54 INFO - 2016-02-08 10:09:54,230 INFO : javascript benchmark 10:09:54 INFO - 2016-02-08 10:09:54,230 DEBUG : Working with test: v8_7 10:09:54 INFO - 2016-02-08 10:09:54,230 DEBUG : Generating results file: v8_7 10:09:54 INFO - 2016-02-08 10:09:54,231 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:54 INFO - 2016-02-08 10:09:54,284 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:09:54 INFO - 2016-02-08 10:09:54,284 DEBUG : process_Request line: dromaeo_css 7438.13 graph.html#tests=[[72,53,35]] 10:09:54 INFO - 2016-02-08 10:09:54,284 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:54 INFO - 2016-02-08 10:09:54,313 DEBUG : process_Request line: kraken 1470.50 graph.html#tests=[[232,53,35]] 10:09:54 INFO - 2016-02-08 10:09:54,313 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:54 INFO - 2016-02-08 10:09:54,344 DEBUG : process_Request line: v8_7 23244.75 graph.html#tests=[[230,53,35]] 10:09:54 INFO - 2016-02-08 10:09:54,346 INFO : javascript benchmark 10:09:54 INFO - 2016-02-08 10:09:54,349 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3276.8197749123797, 3330.250693593943, 3354.3123659649773, 3366.9831650841757, 3374.2745309758407, 5454.318210223722, 5472.616916815815, 5487.314085739283, 5508.9999999999945, 5511.090670039449, 5456.781728730856, 5471.644343117695, 5480.890382192354, 5496.890062198753, 5508.118701007839, 4844.07962487128, 5000.274960130788, 5045.697258164503, 5069.163588007974, 5101.132807422729, 5014.247862820588, 5082.618803589727, 5084.186530155176, 5086.033653605821, 5087.287779710843, 4929.926051109236, 5003.874903127433, 5015.874603134915, 5026.321446604698, 5054.241863720435, 5045.192769156935, 5142.897142057138, 5147.124988751922, 5147.845564633067, 5171.405288391846, 4771.737554434505, 5052.0, 5057.9494205057845, 5077.0, 5123.513266239701, 5269.947300527022, 5281.260623512711, 5299.390570084451, 5327.254184414146, 5340.172273297645, 5875.0, 5925.08161235005, 5928.49607783339, 5930.3773103823905, 5938.5546084043435, 5774.595778295521, 5849.356570777211, 5909.054551271819, 5938.970305148489, 5940.108983652443, 5426.810061647823, 5497.147942068986, 5521.861953451155, 5523.6685798851395, 5527.474889885495, 6012.248468941382, 6020.09698545213, 6021.488173505301, 6067.453929146398, 6078.0, 5527.861803454865, 5683.8010669626365, 5727.742251598688, 5828.854278643068, 5848.941510584925, 5955.779065291605, 5979.9535081361455, 5989.1615173874825, 5993.700314984233, 6003.909941350883, 5901.085331773582, 5939.524838012949, 5944.791932282349, 5949.286085669661, 5956.910646340309, 5668.461496157858, 5760.251167348301, 5935.465808077293, 5936.970315148483, 5939.821805345847, 4462.0, 4528.41130653013, 4528.864134075983, 4543.522930092358, 4553.021100463417, 4057.3102572562734, 4060.715749897479, 4063.593640635913, 4081.551029386765, 4096.9795151024055, 5350.491703288181, 5493.450654934474, 5634.070378387521, 5635.915461268084, 5638.295213098363, 5807.186993820868, 5883.14694369314, 5890.116482527569, 5902.61632993854, 5922.73347699346, 5514.172874068841, 5520.199571062173, 5526.336839579276, 5535.169724541351, 5542.445755424506, 4931.778069986859, 5001.824936127291, 5013.423456302499, 5080.618953578422, 5116.513931176532, 6091.725872335755, 6103.969480152571, 6105.48103411215, 6106.908396374058, 6108.908366374508, 5923.229980102559, 5930.377310382348, 5946.940530594812, 5951.91072133927, 5955.0, 5876.529877609695, 5935.465808077293, 5986.4013598639785, 6048.84877878039, 6139.355367686508, 5784.132380143013, 5786.247787787561, 5787.131930210502, 5787.536997040311, 5788.594798364074, 5815.360310365941, 5843.181954526454, 5853.09277062056, 5857.062869940789, 5857.941420585739, 5509.669419834822, 5666.9716651416475, 5704.372519022987, 5790.276215473066, 5811.651300921958, 5760.913586296293, 5793.826185214451, 5799.8550036249435, 5801.100829371454, 5802.564807639528, 5451.100568406168, 5725.398833122462, 5733.71331433435, 5736.627119237236, 5737.512311453574, 5631.408702086386, 5839.941600584109, 5907.763689452374, 5940.79207227745, 5977.3126090500145, 5665.716714164358, 5672.659640421588, 5677.205191273142, 5685.488306052475, 5687.573431992534], "unit": "ms", "name": "dojo.html", "value": 5436.201719881636}, {"lowerIsBetter": false, "replicates": [633.85738208903, 637.9776707815224, 638.5976834594206, 646.6088016749866, 652.4584594786328, 40828.38757418641, 41973.58026419731, 42030.15939681204, 42030.57969420312, 42065.158696826045, 46355.07289854201, 46877.0, 46966.0, 47009.0, 47040.2943955841, 8034.236747509007, 8121.30968867647, 9085.682001129979, 9272.907270927271, 10439.947800260989, 10626.521806518725, 10738.463076846165, 10739.677809665684, 10747.140228781678, 10750.623728169516, 10782.46087695616, 10851.0, 10857.565697372096, 10933.234673572853, 10944.0, 8209.38429617781, 8404.915950840536, 10958.28771129874, 11203.21577489568, 11208.383538905357, 10545.209109316833, 10684.19868509857, 10684.465776711133, 10685.305455145392, 10698.090662293715, 42184.36723449151, 42431.0, 42557.723268302, 42694.78652606717, 42704.35943460851, 3682.594914559423, 3803.2963901678277, 4083.122128742305, 4150.522689890671, 4259.105587826529, 32182.51726224085, 32620.0, 32688.182795430068, 33025.174370640685, 33182.50226246584, 4304.397384366192, 4323.632491238217, 4368.737875727466, 4374.212641724488, 4400.911981760379, 276678.0, 277247.0, 277544.0, 278120.0, 278366.0, 58191.12713309304, 59085.70457147687, 67877.0, 68316.0, 68328.0, 78709.21290787018, 79810.20189798143, 80102.59948700336, 80134.59932700415, 80226.0, 16408.0, 16744.162791860603, 16745.581360465843, 16756.16219189036, 16783.0, 12890.48438062467, 12985.935070324587, 13000.544980925622, 13019.934900325437, 13023.47906083765, 21871.45321366947, 22146.446338841335, 22240.221592244194, 22278.665820012713, 22314.442138946655, 8124.390670699721, 8156.0, 8268.586570671443, 8340.332773378115, 8377.204165604258, 1074.1889873145724, 1079.6653037558383, 1117.80997230471, 1140.6521011091697, 1200.8739082396398, 30263.697363026527, 30430.239244018634, 30465.0, 30565.847170764006, 31211.531827022613, 1133.659902029388, 1209.6414666283604, 1219.536576101076, 1225.2464734188588, 1228.3673907937418, 13816.894648428102, 15806.762898556532, 16004.839951600336, 16086.839131608534, 16681.499555013368, 337208.0, 343590.0, 343654.0, 344633.66099017067, 344646.0, 57354.0, 57502.424975750546, 57648.71175644095, 57687.0, 57787.711061444425, 1448.5292280008828, 1454.8254209494928, 1462.349254581701, 1465.3039806092233, 1474.8820094392422, 31462.056138315886, 31465.52801708022, 31785.523217152222, 31858.840705796323, 31972.84013579917, 51735.2239716397, 51864.481355187476, 52443.0, 52468.47531524636, 52481.21278180907, 326934.0, 329079.0, 329177.0, 329233.0, 329968.0, 30875.382492349578, 31155.532667010466, 34561.30877382489, 34625.30749385049, 35128.0, 40064.59935400609, 40678.18643627052, 40680.59319406887, 40987.7950610245, 41807.37288940729, 34123.0, 34636.0, 34803.0, 34950.65049349474, 35199.47200791939, 32821.507677385336, 37779.995011224746, 38067.525610835204, 42445.57554424416, 42775.14449711051, 36940.26119477649, 37182.628173717916, 37884.0, 37923.62076379201, 38118.0, 32390.514142287415, 34509.0, 34749.37042810913, 35052.12369690676, 35092.473612895315, 26468.735312646626, 27023.594646080717, 34483.13792155216, 34741.305173896886, 36974.0], "unit": "ms", "name": "ext.html", "value": 20431.648316272174}, {"lowerIsBetter": false, "replicates": [382.10015413700717, 384.8013438140192, 387.16565800699493, 390.61914633232584, 394.8598247622094, 15354.385824567004, 15490.0, 16692.248848801803, 18077.548061298476, 18085.819141808577, 17996.280148794067, 18044.81955180451, 18338.541536461595, 18363.357282495115, 18370.540736481595, 6033.909491357633, 6155.569110162291, 6157.415045570686, 6162.476189523896, 6170.444659980601, 4630.0739852029565, 4744.264638980946, 6030.246219222598, 6795.7621483248095, 6988.545744526615, 5459.590530710193, 6897.068895699092, 6916.412104971084, 6921.930780692204, 6958.338957799001, 5582.637128586629, 5600.355959064719, 5603.991281569336, 5604.607677462579, 5605.047141985852, 5318.388385335697, 5407.270018547485, 5408.891822163574, 5416.1063424534905, 5437.809676661337, 13929.860701392958, 14110.365033573515, 14120.717585648332, 18486.722699159523, 22683.659745103836, 2317.2121478697154, 2436.8294219404647, 2463.5811911975006, 2504.4114633061217, 2541.936451588725, 10374.118199953013, 11554.133439992034, 12418.875811241862, 13474.52839150625, 14162.92918535411, 1926.3835572616767, 1935.4097000414868, 1955.286320493024, 1972.142118178597, 2032.6849338352579, 63252.0, 65422.0, 65803.0, 66236.66881665561, 67800.3219967799, 10455.581776728846, 10472.947635261775, 10487.632932847466, 10623.150147988143, 10817.83773243402, 13686.93156534231, 13702.45190192401, 13721.519746808814, 13745.38145783422, 13761.724765504634, 8141.959290203511, 8321.6671333146, 8366.748997530083, 8411.70559030431, 8568.314534837198, 8633.91366086331, 8670.609822558, 8691.217790398894, 8738.475691458405, 8755.255803256794, 4325.567443255649, 4593.402857628487, 4666.533346665306, 4700.412448443944, 4744.620430365562, 1794.605186858889, 1833.9215754601005, 1930.2375561653068, 1949.1228946973918, 1960.607878424321, 819.5861090149436, 884.5842454046588, 886.8403687336213, 910.5765818894246, 947.976300592477, 15172.468963586442, 17525.386611468537, 17652.91173544124, 17768.555786105193, 18937.526561835788, 1043.5512729526376, 1051.3429106808244, 1087.532361084741, 1091.8908109189017, 1104.7956128116325, 10249.692509224735, 10378.221633377376, 10461.633842815465, 10472.319299245524, 10493.26547141708, 695236.0, 712118.0, 714491.0, 725731.0, 729421.0, 83145.58427207825, 83156.58421707853, 85239.57380213059, 85332.0, 85837.0, 1253.0414233111676, 1255.428779905141, 1262.9684257893625, 1264.0835394339215, 1272.516443751387, 15548.222588870285, 15930.362785488915, 16277.837221628106, 16480.587985300463, 16570.254338554554, 33714.0, 34238.315233695685, 34301.48547771735, 34980.82509587436, 36926.0, 46738.065238695715, 47407.0, 48965.510344896094, 49111.26333104935, 52721.20918186307, 10398.168146548107, 10467.685969420625, 10534.420606866695, 10592.099671528007, 10661.946690266499, 11949.103817213918, 12032.75934481288, 12133.635990920286, 16652.58368540796, 19159.137838797567, 15449.922750386626, 15738.685226295182, 15875.126868021907, 15974.920125399298, 16281.837181628032, 12053.63839084829, 14877.776833347292, 15742.763858541903, 15883.364665413254, 16243.51269461918, 14626.049306795025, 14809.777853331992, 14930.701385972003, 14935.17856517902, 15027.323770430576, 9854.753631159278, 10320.793584128125, 10410.68767936963, 10411.11505522039, 10464.790704185722, 14963.102213867203, 15043.247837608295, 15431.459898903484, 15531.301091451138, 16027.519174424786], "unit": "ms", "name": "jquery.html", "value": 9502.176581772374}, {"lowerIsBetter": false, "replicates": [1550.7673848922661, 1617.2479796894445, 1623.886327957042, 1814.5282226621082, 1918.3957053528138, 7999.0, 8262.586870656465, 8263.710770123047, 8265.132161123085, 8266.50400975942, 7480.251974802517, 7657.042869641295, 8048.195180481949, 8254.669813207465, 8291.046529649093, 2352.2590384029063, 2369.490559529701, 2380.1907351500486, 2388.7133543974746, 2391.175044609607, 2189.5839790439845, 2429.149797570854, 2441.56051910656, 2489.116363690891, 2491.713452952906, 2124.468882779305, 2335.509542995973, 2361.7756313150308, 2374.6912901322803, 2377.8573285602833, 2317.4553979814814, 2334.9299521014395, 2346.8122550195944, 2379.5240951809533, 2380.8928598213124, 2369.04053858186, 2371.0634299451795, 2389.952200955971, 2404.699412573428, 2415.6014257647466, 8419.621117049748, 8481.194286542768, 8487.533185674785, 8498.277646400064, 8504.0, 5019.698818070891, 5099.923501147486, 5118.897622047538, 5135.332406787131, 5137.8201762938115, 3229.4994275887275, 3237.5629290045777, 3277.7869438486423, 3312.5031245313153, 3336.282699219655, 979.9559019844124, 995.5420506566987, 1012.7012531303283, 1023.488255872064, 1039.0544604410027, 11894.226875253082, 11903.88096119045, 11908.821367679491, 11914.523419063227, 11915.761684766343, 4585.908281834345, 4600.95399046012, 4624.97687511567, 4662.7668616569035, 4663.533646635309, 10140.442275674908, 10182.490875456198, 10196.643117490852, 10199.18406527476, 10212.336198147097, 5177.896442071137, 5206.140986737221, 5207.739613019334, 5211.4527974562125, 5216.061109000417, 4683.95316046842, 4716.787744551435, 4717.268823332389, 4718.551737584924, 4724.314974328772, 3828.617138286149, 3843.6925045996254, 3866.1881004988704, 3885.1646895917515, 3885.572587015426, 1242.1180961517423, 1262.2300396757971, 1272.917260378091, 1286.5304163980268, 1299.7725398055302, 1196.617082533581, 1221.9816702749465, 1222.3582619124852, 1365.8224430824127, 1382.4884792626592, 8084.070331911906, 8114.310283625958, 8222.095569487352, 8239.546824924566, 8246.09292977772, 1196.8264601632889, 1203.8796120388067, 1204.9156559040957, 1238.2817965579943, 1241.1498123785236, 6370.394812492806, 6382.521310901701, 6429.967850160813, 6432.163818703539, 6437.0988061671405, 10053.693019907512, 10307.330023548595, 10325.173986081245, 10431.791364172674, 10438.425886576311, 9951.950240248752, 10107.191424686154, 10224.846627300596, 10229.48852557384, 10264.973502649675, 8014.0, 8099.14958929304, 8103.635336409876, 8108.5540295283145, 8119.188081191952, 7953.562554059582, 7991.041075071029, 8015.83968320642, 8062.55655938929, 8092.0, 8918.910810892068, 8975.955120224357, 9057.77355566116, 9110.271178305587, 9124.635014599342, 9032.45805251687, 9237.03011183816, 9256.305777066882, 9422.199113075465, 9449.338546301968, 7733.110692270461, 7738.2261773822165, 7811.414143939113, 7829.138794732461, 7829.804254893445, 8376.958115209385, 8421.70524031656, 8442.240198382175, 8446.239838414573, 8451.0, 6714.52998290115, 7813.609319534115, 7844.294013538809, 7921.485103468256, 8070.596470176585, 7694.461387703031, 7698.0, 7728.227177282227, 7800.102988156208, 7810.570418626803, 7586.241375862591, 7621.542707437349, 7635.045619297588, 7637.732679356196, 7650.0, 6723.394894459522, 6869.072675188786, 6875.278095799869, 7157.821054473679, 7255.854882902207, 7110.146782386147, 7115.0, 7152.284771522806, 7173.10336207974, 7187.0], "unit": "ms", "name": "mootools.html", "value": 4867.913756852833}, {"lowerIsBetter": false, "replicates": [351.33948177426436, 356.9696575791058, 357.30504169390537, 363.53104495201194, 365.57410616631626, 5838.854028649275, 5917.585768996172, 5973.850653733659, 5984.850378740533, 6021.187139736135, 5801.709914504268, 5926.733297001634, 5936.0, 5939.287285525743, 5954.4938680212235, 4661.720296782187, 4672.4393072831135, 4675.345451636774, 4676.532346765313, 4683.555062269079, 4669.369635099269, 4679.15775160471, 4683.531646835323, 4684.5315468453055, 4686.90626187476, 4550.749708766017, 4636.09596128755, 4640.582347588716, 4642.535746425364, 4649.488556258809, 4625.051864367797, 4630.166570017395, 4636.374089497908, 4643.0017546227555, 4648.1168577970075, 3833.1758671885677, 4116.197341518405, 4117.75293482389, 4118.732282401635, 4128.215639028605, 5512.614117011811, 5525.557955363562, 5646.265985421869, 5666.575006874501, 5670.489655930986, 5343.225232341289, 5344.91982620261, 5368.033753924292, 5380.838574842722, 5388.110961691316, 6297.464715499188, 6312.053192021233, 6319.052142178664, 6322.810315690536, 6325.209348831396, 4455.799489022969, 4540.682152249344, 4540.682152249344, 4540.909181816378, 4551.180787458256, 6536.673166341664, 6536.803895883084, 6539.47684185264, 6541.345865413468, 6545.37818907203, 4669.322948172564, 4673.60274376675, 4674.439067311944, 4676.69601475903, 4676.929846052312, 4629.65277604181, 4733.597644200281, 4734.455537613149, 4735.573798358164, 4736.384270044872, 5324.946750532523, 5335.839924802262, 5338.54622357104, 5338.946610533845, 5338.9466105339225, 6312.368763123651, 6328.810135695937, 6330.715117819709, 6332.620042797447, 6338.619682819046, 1641.1302009934755, 1655.2964989879254, 1662.950111496657, 1663.2432243329256, 1663.2931004323113, 1143.3482914738686, 1145.633397312852, 1146.9713257168637, 1163.313644949467, 1173.208084542947, 6169.629822210682, 6177.0, 6178.7219575119225, 6180.938190618126, 6181.690915454209, 6512.446442052384, 6512.8602494563265, 6520.250171230275, 6523.347665233438, 6528.673566321665, 6073.878522429615, 6212.0371342441995, 6212.596181248205, 6215.533834962305, 6221.440070393686, 3456.948145777815, 3483.1814523586936, 3483.6168021517615, 3489.354469423165, 3520.2255503789124, 6614.305497922745, 6711.429528490133, 6736.0, 6800.047993280945, 6901.515454436399, 6702.061711360413, 6730.9326906731285, 6765.0, 6767.052612634235, 6768.0, 6824.283450237753, 6829.897551536731, 6870.931290687129, 6872.381485666314, 6878.828029299308, 6401.615903045832, 6583.572067815577, 6590.670466476753, 6590.736370545124, 6594.769183078569, 6506.967465162644, 6507.023946408077, 6513.2835388108215, 6516.478681705547, 6517.3808488193545, 6862.725490980305, 6868.450523957971, 6874.278200788845, 6875.243723190345, 6881.552699074544, 4461.843835465743, 4584.564466375689, 4600.378948841997, 4600.470945841137, 4602.4477062752685, 6549.7380104795275, 6554.279029306867, 6555.96722016406, 6556.311587283267, 6560.967195163994, 6333.714982825692, 6371.980483122678, 6387.690523442776, 6392.105105285357, 6403.103565500741, 6259.624422534663, 6384.329645387354, 6386.233651961795, 6389.808305750835, 6397.776077837253, 6290.905636415366, 6304.71628776697, 6307.558470906993, 6311.400416960381, 6314.778982735582, 6387.201599800025, 6394.1687580614225, 6394.968025159845, 6395.584287021329, 6403.29563747978, 6144.262688477412, 6252.0, 6257.2804127525915, 6262.686865656608, 6269.122322874892], "unit": "ms", "name": "prototype.html", "value": 4845.305024852632}, {"lowerIsBetter": false, "replicates": [768.577282494628, 798.4131663227527, 821.6261600971558, 883.1565854608849, 978.349397650562, 14626.780598291021, 14649.853501464982, 14766.114033158017, 14780.852191478081, 14789.408423663053, 14062.367193476293, 14075.155490670568, 14087.788683169761, 14142.717145657081, 14143.009989300754, 735.6542425060213, 746.4028776978423, 867.8307729992654, 889.208604342136, 903.1465265324272, 891.4205766251923, 895.6238379880433, 900.0189793125492, 900.2572877376158, 901.0223907060814, 941.7786820097272, 945.0927109974433, 945.6170251048336, 953.3326671330062, 953.7806304549957, 781.7107670162048, 786.0724345272577, 934.4159900062461, 947.2895328503622, 951.7477868364889, 702.0978043214445, 704.9506534542584, 705.1538154214911, 706.1138271469273, 708.2032713197652, 14107.929460352736, 14171.78742318866, 14221.21783301918, 14226.075305105238, 14226.857731422657, 12105.515779368814, 12765.55320563785, 13294.20234785916, 13655.795163072562, 14101.506447274398, 11450.713732156679, 11981.041516678732, 12136.211146275464, 12261.570845020382, 12439.937800310941, 3935.311320518898, 3957.426173204898, 4025.376066709665, 4194.790260486963, 4195.769232692201, 48940.0, 49116.508834911554, 50329.24506132411, 50423.243651345256, 51051.48948510542, 10262.332948358333, 10371.429571373495, 10478.056974872297, 10660.520276587573, 10683.893161068445, 19162.04189790505, 19343.613127737648, 19378.70931936022, 19390.12744426476, 19404.0, 8131.674733010614, 8221.424500285042, 8471.279941204943, 8551.358648101417, 8618.482891026559, 4597.057603191338, 4598.908021839545, 4649.465311489154, 4755.9286610700865, 4800.879978000578, 3388.15296175956, 3415.026717385533, 3438.3639026780124, 3442.087846720621, 3444.293919746446, 598.2103623217398, 616.5899676714935, 622.3061286665336, 633.0441034038635, 636.1793286660156, 726.851989201062, 732.4835990626596, 738.4018944654847, 740.1007775552729, 746.3320328306136, 8858.15847494487, 9043.68347107848, 9062.773430664287, 9069.727908162766, 9231.0, 724.9855002899913, 755.7732680196029, 759.9050118735158, 761.1779278379337, 769.4959801330137, 4199.118185181085, 4333.15503476819, 4429.136318417877, 4500.819967201341, 4535.705179163344, 59156.40843591595, 60537.09194362088, 60930.69534652387, 60946.39053609496, 61074.0, 53576.196357053894, 54951.17573236405, 54987.45012549823, 55388.44611553913, 55447.44552554504, 48429.27356089662, 48476.7576162117, 48814.02371952541, 48965.0, 49464.25803612949, 8747.300215982834, 8810.251128654136, 8818.162274583905, 9049.638014479347, 9146.0, 37073.629263707015, 37701.434478483396, 38572.22855542817, 38574.6142538571, 38575.22849542937, 43545.12909741851, 43808.56191438045, 45574.31638525359, 48757.268640971124, 48835.26747098725, 11529.250598711056, 11632.709182270512, 11901.285922844658, 11972.700682482659, 12036.976856966905, 12835.165714228546, 12894.742105158031, 13167.53913613019, 13435.798463023259, 13806.318331744787, 11597.246178998337, 11771.47028383742, 12010.219335743148, 12044.638660840188, 12183.878161218629, 11288.59751629069, 11743.47154378072, 11782.52869885195, 12018.63944081644, 12161.33112678811, 11527.711807204887, 11967.222130561486, 12062.577809776616, 12127.090468214743, 12129.575464858688, 10398.428086455318, 10630.84053739179, 10649.307794993301, 10937.890621094006, 11317.547298108313, 9387.436753794795, 9733.9026609733, 9885.357451765612, 9977.151942085004, 10003.499825008575], "unit": "ms", "name": "yui.html", "value": 6802.3392647917835}], "name": "dromaeo_css", "value": 7438.132773568238}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 109.0, 111.0, 109.0, 99.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 145.0, 152.0, 123.0, 148.0, 154.0, 122.0, 162.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 158.0, 159.0, 159.0, 159.0, 160.0, 162.0, 159.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 159.5}, {"lowerIsBetter": true, "replicates": [71.0, 77.0, 72.0, 155.0, 72.0, 72.0, 71.0, 73.0, 162.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 92.0, 93.0, 93.0, 140.0, 92.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [108.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 58.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 81.0, 78.0, 79.0, 86.0, 77.0, 78.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 127.0, 113.0, 114.0, 126.0, 122.0, 110.0, 114.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [131.0, 142.0, 144.0, 134.0, 141.0, 135.0, 140.0, 142.0, 140.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1470.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "Richards", "value": 213.9301200000001}, {"lowerIsBetter": false, "replicates": [170.9986320109439], "unit": "score", "name": "DeltaBlue", "value": 386.6580640000002}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [543.773790103317], "unit": "score", "name": "Earley", "value": 1225.6254570000006}, {"lowerIsBetter": false, "replicates": [10547.368421052632], "unit": "score", "name": "Boyer", "value": 63.187609780439146}, {"lowerIsBetter": false, "replicates": [24333.333333333332], "unit": "score", "name": "RegExp", "value": 37.437739726027424}, {"lowerIsBetter": false, "replicates": [524.8821372446307], "unit": "score", "name": "Splay", "value": 155.25580738522953}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23244.749862389333}]} 10:09:54 INFO - RETURN: dromaeo_css: 7438.13 10:09:54 INFO - RETURN: kraken: 1470.50 10:09:54 INFO - RETURN: v8_7: 23244.75 10:09:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23244.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7438.13"}}} 10:09:54 INFO - Return code: 0 10:09:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:09:54 INFO - # TBPL SUCCESS # 10:09:54 INFO - Running post-action listener: _resource_record_post_action 10:09:54 INFO - Running post-run listener: _resource_record_post_run 10:09:55 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 522215424; Read time: 0; Write time: 1464648 10:09:55 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 251326464; Read time: 0; Write time: 889712 10:09:55 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 270888960; Read time: 0; Write time: 574936 10:09:55 INFO - Running post-run listener: _upload_blobber_files 10:09:55 INFO - Blob upload gear active. 10:09:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:09:55 INFO - Copying logs to upload dir... 10:09:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.664736 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-08 10:09:55.484001) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-08 10:09:55.487854) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010156 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454945066/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-08 10:09:55.539559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:09:55.539880) ========= 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-1454953730.612493-288498663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:09:55.589580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:09:55.589886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:09:55.590173) ========= ========= Total master_lag: 0.27 =========