builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1455228424.68 results: success (0) buildid: 20160211113534 builduid: 810f11598cd84cb9a369591b68822074 revision: fb1653512406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.682366) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.682822) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.683103) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.705701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.705976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.718793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.719074) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.767877) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.768160) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.768513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.768786) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 14:07:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-02-11 14:07:04 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.918531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.918835) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.967970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:04.968320) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fb1653512406 --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 fb1653512406 --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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 14:07:05,108 Setting DEBUG logging. 2016-02-11 14:07:05,108 attempt 1/10 2016-02-11 14:07:05,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fb1653512406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 14:07:05,475 unpacking tar archive at: mozilla-beta-fb1653512406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:05.634014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:05.634369) ========= echo fb1653512406 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fb1653512406'] 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fb1653512406 program finished with exit code 0 elapsedTime=0.004672 script_repo_revision: 'fb1653512406' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:05.684944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:05.685275) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 14:07:05.694732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-11 14:07:05.695014) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:05 INFO - MultiFileLogger online at 20160211 14:07:05 in /builds/slave/test-pgo 14:07:05 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 14:07:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:07:05 INFO - {'append_to_log': False, 14:07:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:07:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:07:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:07:05 INFO - 'branch': 'Mozilla-Beta', 14:07:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:05 INFO - 'config_files': ('talos/linux_config.py',), 14:07:05 INFO - 'default_actions': ('clobber', 14:07:05 INFO - 'read-buildbot-config', 14:07:05 INFO - 'download-and-extract', 14:07:05 INFO - 'populate-webroot', 14:07:05 INFO - 'create-virtualenv', 14:07:05 INFO - 'install', 14:07:05 INFO - 'run-tests'), 14:07:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:05 INFO - 'download_minidump_stackwalk': True, 14:07:05 INFO - 'download_symbols': 'ondemand', 14:07:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:05 INFO - 'installer_path': 'installer.exe', 14:07:05 INFO - 'log_level': 'info', 14:07:05 INFO - 'log_name': 'talos', 14:07:05 INFO - 'log_to_console': True, 14:07:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:05 INFO - 'opt_config_files': (), 14:07:05 INFO - 'pip_index': False, 14:07:05 INFO - 'sps_profile': False, 14:07:05 INFO - 'sps_profile_interval': 0, 14:07:05 INFO - 'suite': 'dromaeojs', 14:07:05 INFO - 'system_bits': '32', 14:07:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:05 INFO - 'title': 'talos-linux64-ix-019', 14:07:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:05 INFO - 'use_talos_json': True, 14:07:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:07:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:05 INFO - 'work_dir': 'build'} 14:07:05 INFO - ##### 14:07:05 INFO - ##### Running clobber step. 14:07:05 INFO - ##### 14:07:05 INFO - Running pre-action listener: _resource_record_pre_action 14:07:05 INFO - Running main action method: clobber 14:07:05 INFO - rmtree: /builds/slave/test-pgo/build 14:07:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:07:06 INFO - Running post-action listener: _resource_record_post_action 14:07:06 INFO - ##### 14:07:06 INFO - ##### Running read-buildbot-config step. 14:07:06 INFO - ##### 14:07:06 INFO - Running pre-action listener: _resource_record_pre_action 14:07:06 INFO - Running main action method: read_buildbot_config 14:07:06 INFO - Using buildbot properties: 14:07:06 INFO - { 14:07:06 INFO - "properties": { 14:07:06 INFO - "buildnumber": 81, 14:07:06 INFO - "product": "firefox", 14:07:06 INFO - "script_repo_revision": "production", 14:07:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:07:06 INFO - "repository": "", 14:07:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:07:06 INFO - "buildid": "20160211113534", 14:07:06 INFO - "slavename": "talos-linux64-ix-019", 14:07:06 INFO - "pgo_build": "True", 14:07:06 INFO - "basedir": "/builds/slave/test-pgo", 14:07:06 INFO - "project": "", 14:07:06 INFO - "platform": "ubuntu64_hw", 14:07:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:07:06 INFO - "slavebuilddir": "test", 14:07:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:07:06 INFO - "branch": "mozilla-beta", 14:07:06 INFO - "repo_path": "releases/mozilla-beta", 14:07:06 INFO - "stage_platform": "linux64-pgo", 14:07:06 INFO - "builduid": "810f11598cd84cb9a369591b68822074", 14:07:06 INFO - "revision": "fb1653512406" 14:07:06 INFO - }, 14:07:06 INFO - "sourcestamp": { 14:07:06 INFO - "repository": "", 14:07:06 INFO - "hasPatch": false, 14:07:06 INFO - "project": "", 14:07:06 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:07:06 INFO - "changes": [ 14:07:06 INFO - { 14:07:06 INFO - "category": null, 14:07:06 INFO - "files": [ 14:07:06 INFO - { 14:07:06 INFO - "url": null, 14:07:06 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2" 14:07:06 INFO - } 14:07:06 INFO - ], 14:07:06 INFO - "repository": "", 14:07:06 INFO - "rev": "fb1653512406", 14:07:06 INFO - "who": "sendchange", 14:07:06 INFO - "when": 1455228152, 14:07:06 INFO - "number": 7596605, 14:07:06 INFO - "comments": "Bug 1243549 - Add missing bits. r=post-facto a=sylvestre", 14:07:06 INFO - "project": "", 14:07:06 INFO - "at": "Thu 11 Feb 2016 14:02:32", 14:07:06 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 14:07:06 INFO - "revlink": "", 14:07:06 INFO - "properties": [ 14:07:06 INFO - [ 14:07:06 INFO - "buildid", 14:07:06 INFO - "20160211113534", 14:07:06 INFO - "Change" 14:07:06 INFO - ], 14:07:06 INFO - [ 14:07:06 INFO - "builduid", 14:07:06 INFO - "810f11598cd84cb9a369591b68822074", 14:07:06 INFO - "Change" 14:07:06 INFO - ], 14:07:06 INFO - [ 14:07:06 INFO - "pgo_build", 14:07:06 INFO - "True", 14:07:06 INFO - "Change" 14:07:06 INFO - ] 14:07:06 INFO - ], 14:07:06 INFO - "revision": "fb1653512406" 14:07:06 INFO - } 14:07:06 INFO - ], 14:07:06 INFO - "revision": "fb1653512406" 14:07:06 INFO - } 14:07:06 INFO - } 14:07:06 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2. 14:07:06 INFO - Running post-action listener: _resource_record_post_action 14:07:06 INFO - ##### 14:07:06 INFO - ##### Running download-and-extract step. 14:07:06 INFO - ##### 14:07:06 INFO - Running pre-action listener: _resource_record_pre_action 14:07:06 INFO - Running main action method: download_and_extract 14:07:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:07: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')]} 14:07:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/test_packages.json 14:07:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:07:06 INFO - Downloaded 1270 bytes. 14:07:06 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:07:06 INFO - Using the following test package requirements: 14:07:06 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 14:07:06 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:06 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'jsshell-linux-x86_64.zip'], 14:07:06 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:06 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 14:07:06 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 14:07:06 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 14:07:06 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:06 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 14:07:06 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 14:07:06 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:06 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07: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')]} 14:07:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.common.tests.zip 14:07:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:07 INFO - Downloaded 21582132 bytes. 14:07:07 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 14:07:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 14:07:07 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 14:07:08 INFO - Return code: 0 14:07:08 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 14:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.common.tests.zip 14:07:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:08 INFO - Downloaded 21582132 bytes. 14:07:08 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 14:07:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 14:07:08 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 14:07:10 INFO - Return code: 0 14:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 14:07:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:10 INFO - Downloaded 11132038 bytes. 14:07:10 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 14:07:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 14:07:10 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 14:07:10 INFO - Return code: 0 14:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2 14:07:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/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 14:07:11 INFO - Downloaded 57940643 bytes. 14:07:11 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2 14:07:11 INFO - mkdir: /builds/slave/test-pgo/properties 14:07:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:07:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:07:11 INFO - Contents: 14:07:11 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2 14:07:11 INFO - Running post-action listener: _resource_record_post_action 14:07:11 INFO - Running post-action listener: set_extra_try_arguments 14:07:11 INFO - ##### 14:07:11 INFO - ##### Running populate-webroot step. 14:07:11 INFO - ##### 14:07:11 INFO - Running pre-action listener: _resource_record_pre_action 14:07:11 INFO - Running main action method: populate_webroot 14:07:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:07:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:07:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:07:11 INFO - '--tppagecycles', 14:07:11 INFO - '7'], 14:07:11 INFO - 'tests': ['tsvgm']}}, 14:07:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:07:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:07:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:07:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'tests': ['damp', 'tps']}, 14:07:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['damp', 'tps']}, 14:07:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:07:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:11 INFO - 'other': {'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'other_l64': {'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'other_nol64': {'tests': ['a11yr', 14:07:11 INFO - 'ts_paint', 14:07:11 INFO - 'tpaint', 14:07:11 INFO - 'sessionrestore', 14:07:11 INFO - 'sessionrestore_no_auto_restore']}, 14:07:11 INFO - 'svgr': {'tests': ['tsvgx', 14:07:11 INFO - 'tsvgr_opacity', 14:07:11 INFO - 'tart', 14:07:11 INFO - 'tscrollx', 14:07:11 INFO - 'cart']}, 14:07:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['tsvgx', 14:07:11 INFO - 'tsvgr_opacity', 14:07:11 INFO - 'tart', 14:07:11 INFO - 'tscrollx', 14:07:11 INFO - 'cart']}, 14:07:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'tests': ['tp5o']}, 14:07:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'talos_options': ['--e10s'], 14:07:11 INFO - 'tests': ['tp5o']}, 14:07:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'talos_options': ['--xperf_path', 14:07:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:11 INFO - 'tests': ['tp5n']}, 14:07:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:07:11 INFO - 'talos_options': ['--e10s', 14:07:11 INFO - '--xperf_path', 14:07:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:11 INFO - 'tests': ['tp5n']}}, 14:07:11 INFO - 'talos.zip': {'path': '', 14:07:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:07:11 INFO - Running post-action listener: _resource_record_post_action 14:07:11 INFO - ##### 14:07:11 INFO - ##### Running create-virtualenv step. 14:07:11 INFO - ##### 14:07:11 INFO - Running pre-action listener: _resource_record_pre_action 14:07:11 INFO - Running main action method: create_virtualenv 14:07:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:07:11 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 14:07:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:07:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:11 INFO - Using real prefix '/usr' 14:07:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:07:12 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:14 INFO - Installing pip.................done. 14:07:14 INFO - Return code: 0 14:07:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:14 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:14 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 14:07:14 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 14:07:14 INFO - Using env: {'DISPLAY': ':0', 14:07:14 INFO - 'HOME': '/home/cltbld', 14:07:14 INFO - 'LANG': 'en_US.UTF-8', 14:07:14 INFO - 'LANGUAGE': 'en_US:en', 14:07:14 INFO - 'LOGNAME': 'cltbld', 14:07:14 INFO - 'MAIL': '/var/mail/cltbld', 14:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:14 INFO - 'MOZ_NO_REMOTE': '1', 14:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:14 INFO - 'NO_EM_RESTART': '1', 14:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:14 INFO - 'SHELL': '/bin/bash', 14:07:14 INFO - 'SHLVL': '1', 14:07:14 INFO - 'TERM': 'linux', 14:07:14 INFO - 'TMOUT': '86400', 14:07:14 INFO - 'USER': 'cltbld', 14:07:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:14 INFO - '_': '/tools/buildbot/bin/python'} 14:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:14 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 14:07:14 INFO - Cleaning up... 14:07:14 INFO - Return code: 0 14:07:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:14 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:14 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 14:07:14 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 14:07:14 INFO - Using env: {'DISPLAY': ':0', 14:07:14 INFO - 'HOME': '/home/cltbld', 14:07:14 INFO - 'LANG': 'en_US.UTF-8', 14:07:14 INFO - 'LANGUAGE': 'en_US:en', 14:07:14 INFO - 'LOGNAME': 'cltbld', 14:07:14 INFO - 'MAIL': '/var/mail/cltbld', 14:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:14 INFO - 'MOZ_NO_REMOTE': '1', 14:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:14 INFO - 'NO_EM_RESTART': '1', 14:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:14 INFO - 'SHELL': '/bin/bash', 14:07:14 INFO - 'SHLVL': '1', 14:07:14 INFO - 'TERM': 'linux', 14:07:14 INFO - 'TMOUT': '86400', 14:07:14 INFO - 'USER': 'cltbld', 14:07:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:14 INFO - '_': '/tools/buildbot/bin/python'} 14:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:14 INFO - Downloading/unpacking psutil>=0.7.1 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:16 INFO - Installing collected packages: psutil 14:07:16 INFO - Running setup.py install for psutil 14:07:16 INFO - building 'psutil._psutil_linux' extension 14:07:16 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 14:07:16 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 14:07:16 INFO - building 'psutil._psutil_posix' extension 14:07:16 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 14:07:16 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 14:07:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:16 INFO - Successfully installed psutil 14:07:16 INFO - Cleaning up... 14:07:16 INFO - Return code: 0 14:07:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:07: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')]} 14:07:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:16 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:16 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 14:07:16 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 14:07:16 INFO - Using env: {'DISPLAY': ':0', 14:07:16 INFO - 'HOME': '/home/cltbld', 14:07:16 INFO - 'LANG': 'en_US.UTF-8', 14:07:16 INFO - 'LANGUAGE': 'en_US:en', 14:07:16 INFO - 'LOGNAME': 'cltbld', 14:07:16 INFO - 'MAIL': '/var/mail/cltbld', 14:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:16 INFO - 'MOZ_NO_REMOTE': '1', 14:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:16 INFO - 'NO_EM_RESTART': '1', 14:07:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:16 INFO - 'SHELL': '/bin/bash', 14:07:16 INFO - 'SHLVL': '1', 14:07:16 INFO - 'TERM': 'linux', 14:07:16 INFO - 'TMOUT': '86400', 14:07:16 INFO - 'USER': 'cltbld', 14:07:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:16 INFO - '_': '/tools/buildbot/bin/python'} 14:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:07:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:07:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:07:18 INFO - Installing collected packages: mozsystemmonitor 14:07:18 INFO - Running setup.py install for mozsystemmonitor 14:07:19 INFO - Successfully installed mozsystemmonitor 14:07:19 INFO - Cleaning up... 14:07:19 INFO - Return code: 0 14:07:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:07: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')]} 14:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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')]} 14:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07: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', '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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:07: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 blobuploader==1.2.4 14:07:19 INFO - Using env: {'DISPLAY': ':0', 14:07:19 INFO - 'HOME': '/home/cltbld', 14:07:19 INFO - 'LANG': 'en_US.UTF-8', 14:07:19 INFO - 'LANGUAGE': 'en_US:en', 14:07:19 INFO - 'LOGNAME': 'cltbld', 14:07:19 INFO - 'MAIL': '/var/mail/cltbld', 14:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:19 INFO - 'MOZ_NO_REMOTE': '1', 14:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:19 INFO - 'NO_EM_RESTART': '1', 14:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:19 INFO - 'SHELL': '/bin/bash', 14:07:19 INFO - 'SHLVL': '1', 14:07:19 INFO - 'TERM': 'linux', 14:07:19 INFO - 'TMOUT': '86400', 14:07:19 INFO - 'USER': 'cltbld', 14:07:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:19 INFO - '_': '/tools/buildbot/bin/python'} 14:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:07:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:07:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:07:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07: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 14:07:21 INFO - Downloading docopt-0.6.1.tar.gz 14:07:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:07:21 INFO - Installing collected packages: blobuploader, requests, docopt 14:07:21 INFO - Running setup.py install for blobuploader 14:07:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:07:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:07:21 INFO - Running setup.py install for requests 14:07:22 INFO - Running setup.py install for docopt 14:07:22 INFO - Successfully installed blobuploader requests docopt 14:07:22 INFO - Cleaning up... 14:07:22 INFO - Return code: 0 14:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:22 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')]} 14:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 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')]} 14:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:22 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:22 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 14:07:22 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 14:07:22 INFO - Using env: {'DISPLAY': ':0', 14:07:22 INFO - 'HOME': '/home/cltbld', 14:07:22 INFO - 'LANG': 'en_US.UTF-8', 14:07:22 INFO - 'LANGUAGE': 'en_US:en', 14:07:22 INFO - 'LOGNAME': 'cltbld', 14:07:22 INFO - 'MAIL': '/var/mail/cltbld', 14:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:22 INFO - 'MOZ_NO_REMOTE': '1', 14:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:22 INFO - 'NO_EM_RESTART': '1', 14:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:22 INFO - 'SHELL': '/bin/bash', 14:07:22 INFO - 'SHLVL': '1', 14:07:22 INFO - 'TERM': 'linux', 14:07:22 INFO - 'TMOUT': '86400', 14:07:22 INFO - 'USER': 'cltbld', 14:07:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:22 INFO - '_': '/tools/buildbot/bin/python'} 14:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:22 INFO - Running setup.py (path:/tmp/pip-8oZpzV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:22 INFO - Running setup.py (path:/tmp/pip-dzizFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:22 INFO - Running setup.py (path:/tmp/pip-PwlO5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:22 INFO - Running setup.py (path:/tmp/pip-YPCH9t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:22 INFO - Running setup.py (path:/tmp/pip-Rvd6zs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:23 INFO - Running setup.py (path:/tmp/pip-lGlCVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:23 INFO - Running setup.py (path:/tmp/pip-R2286c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:23 INFO - Running setup.py (path:/tmp/pip-qxmc5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:23 INFO - Running setup.py (path:/tmp/pip-fGjvKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:23 INFO - Running setup.py (path:/tmp/pip-7Vgkr_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:23 INFO - Running setup.py (path:/tmp/pip-Z4sIqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:23 INFO - Running setup.py (path:/tmp/pip-9MX_w2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:23 INFO - Running setup.py (path:/tmp/pip-IZavd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:23 INFO - Running setup.py (path:/tmp/pip-7PajC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:23 INFO - Running setup.py (path:/tmp/pip-MlhiOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:23 INFO - Running setup.py (path:/tmp/pip-hN2FUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:23 INFO - Running setup.py (path:/tmp/pip-znd5dW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:07:23 INFO - Running setup.py install for manifestparser 14:07:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:07:23 INFO - Running setup.py install for mozcrash 14:07:24 INFO - Running setup.py install for mozdebug 14:07:24 INFO - Running setup.py install for mozdevice 14:07:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Running setup.py install for mozfile 14:07:24 INFO - Running setup.py install for mozhttpd 14:07:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Running setup.py install for mozinfo 14:07:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Running setup.py install for mozInstall 14:07:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Running setup.py install for mozleak 14:07:24 INFO - Running setup.py install for mozlog 14:07:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:07:24 INFO - Running setup.py install for moznetwork 14:07:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Running setup.py install for mozprocess 14:07:25 INFO - Running setup.py install for mozprofile 14:07:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Running setup.py install for mozrunner 14:07:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Running setup.py install for mozscreenshot 14:07:25 INFO - Running setup.py install for moztest 14:07:25 INFO - Running setup.py install for mozversion 14:07:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:07:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:07:25 INFO - Cleaning up... 14:07:25 INFO - Return code: 0 14:07:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:25 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')]} 14:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 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')]} 14:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:25 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:25 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 14:07:25 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 14:07:25 INFO - Using env: {'DISPLAY': ':0', 14:07:25 INFO - 'HOME': '/home/cltbld', 14:07:25 INFO - 'LANG': 'en_US.UTF-8', 14:07:25 INFO - 'LANGUAGE': 'en_US:en', 14:07:25 INFO - 'LOGNAME': 'cltbld', 14:07:25 INFO - 'MAIL': '/var/mail/cltbld', 14:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:25 INFO - 'MOZ_NO_REMOTE': '1', 14:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:25 INFO - 'NO_EM_RESTART': '1', 14:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:25 INFO - 'SHELL': '/bin/bash', 14:07:25 INFO - 'SHLVL': '1', 14:07:25 INFO - 'TERM': 'linux', 14:07:25 INFO - 'TMOUT': '86400', 14:07:25 INFO - 'USER': 'cltbld', 14:07:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:25 INFO - '_': '/tools/buildbot/bin/python'} 14:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:25 INFO - Running setup.py (path:/tmp/pip-hHeOFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:07:25 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)) 14:07:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:25 INFO - Running setup.py (path:/tmp/pip-Ep032X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:26 INFO - Running setup.py (path:/tmp/pip-mIakEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:26 INFO - Running setup.py (path:/tmp/pip-8zkhzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:26 INFO - Running setup.py (path:/tmp/pip-iEmFdH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:26 INFO - Running setup.py (path:/tmp/pip-VPlDkH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:26 INFO - Running setup.py (path:/tmp/pip-4SnDhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:26 INFO - Running setup.py (path:/tmp/pip-0FHH5C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:26 INFO - Running setup.py (path:/tmp/pip-BEPqIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:26 INFO - Running setup.py (path:/tmp/pip-B0dyGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:26 INFO - Running setup.py (path:/tmp/pip-ypr1za-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:26 INFO - Running setup.py (path:/tmp/pip-oSLiSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:26 INFO - Running setup.py (path:/tmp/pip-C2tO9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:26 INFO - Running setup.py (path:/tmp/pip-FCMuuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:26 INFO - Running setup.py (path:/tmp/pip-PRtG8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:07:26 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)) 14:07:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:26 INFO - Running setup.py (path:/tmp/pip-sbTyV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:07:27 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)) 14:07:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:27 INFO - Running setup.py (path:/tmp/pip-uwIOTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:07:27 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)) 14:07:27 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)) 14:07:27 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)) 14:07:27 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)) 14:07:27 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)) 14:07:27 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)) 14:07:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:07:27 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 14:07:27 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 14:07:27 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 14:07:27 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 14:07:27 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 14:07:27 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 14:07:28 INFO - Downloading blessings-1.6.tar.gz 14:07:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:07:28 INFO - Installing collected packages: blessings 14:07:28 INFO - Running setup.py install for blessings 14:07:29 INFO - Successfully installed blessings 14:07:29 INFO - Cleaning up... 14:07:29 INFO - Return code: 0 14:07:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:07:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:07:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:07:29 INFO - Reading from file tmpfile_stdout 14:07:29 INFO - Current package versions: 14:07:29 INFO - argparse == 1.2.1 14:07:29 INFO - blessings == 1.6 14:07:29 INFO - blobuploader == 1.2.4 14:07:29 INFO - docopt == 0.6.1 14:07:29 INFO - manifestparser == 1.1 14:07:29 INFO - mozInstall == 1.12 14:07:29 INFO - mozcrash == 0.16 14:07:29 INFO - mozdebug == 0.1 14:07:29 INFO - mozdevice == 0.47 14:07:29 INFO - mozfile == 1.2 14:07:29 INFO - mozhttpd == 0.7 14:07:29 INFO - mozinfo == 0.9 14:07:29 INFO - mozleak == 0.1 14:07:29 INFO - mozlog == 3.1 14:07:29 INFO - moznetwork == 0.27 14:07:29 INFO - mozprocess == 0.22 14:07:29 INFO - mozprofile == 0.27 14:07:29 INFO - mozrunner == 6.11 14:07:29 INFO - mozscreenshot == 0.1 14:07:29 INFO - mozsystemmonitor == 0.0 14:07:29 INFO - moztest == 0.7 14:07:29 INFO - mozversion == 1.4 14:07:29 INFO - psutil == 3.1.1 14:07:29 INFO - requests == 1.2.3 14:07:29 INFO - wsgiref == 0.1.2 14:07:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:29 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 14:07:29 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 14:07:29 INFO - Using env: {'DISPLAY': ':0', 14:07:29 INFO - 'HOME': '/home/cltbld', 14:07:29 INFO - 'LANG': 'en_US.UTF-8', 14:07:29 INFO - 'LANGUAGE': 'en_US:en', 14:07:29 INFO - 'LOGNAME': 'cltbld', 14:07:29 INFO - 'MAIL': '/var/mail/cltbld', 14:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:29 INFO - 'MOZ_NO_REMOTE': '1', 14:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:29 INFO - 'NO_EM_RESTART': '1', 14:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:29 INFO - 'SHELL': '/bin/bash', 14:07:29 INFO - 'SHLVL': '1', 14:07:29 INFO - 'TERM': 'linux', 14:07:29 INFO - 'TMOUT': '86400', 14:07:29 INFO - 'USER': 'cltbld', 14:07:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:29 INFO - '_': '/tools/buildbot/bin/python'} 14:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 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)) 14:07:29 INFO - Cleaning up... 14:07:29 INFO - Return code: 0 14:07:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:29 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:29 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 14:07:29 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 14:07:29 INFO - Using env: {'DISPLAY': ':0', 14:07:29 INFO - 'HOME': '/home/cltbld', 14:07:29 INFO - 'LANG': 'en_US.UTF-8', 14:07:29 INFO - 'LANGUAGE': 'en_US:en', 14:07:29 INFO - 'LOGNAME': 'cltbld', 14:07:29 INFO - 'MAIL': '/var/mail/cltbld', 14:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:29 INFO - 'MOZ_NO_REMOTE': '1', 14:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:29 INFO - 'NO_EM_RESTART': '1', 14:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:29 INFO - 'SHELL': '/bin/bash', 14:07:29 INFO - 'SHLVL': '1', 14:07:29 INFO - 'TERM': 'linux', 14:07:29 INFO - 'TMOUT': '86400', 14:07:29 INFO - 'USER': 'cltbld', 14:07:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:29 INFO - '_': '/tools/buildbot/bin/python'} 14:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:29 INFO - Downloading/unpacking jsonschema 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:07:31 INFO - Downloading/unpacking functools32 (from jsonschema) 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 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 14:07:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:07:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:07:31 INFO - warning: no files found matching '*.txt' 14:07:31 INFO - no previously-included directories found matching 'build' 14:07:31 INFO - no previously-included directories found matching 'dist' 14:07:31 INFO - no previously-included directories found matching '.git*' 14:07:31 INFO - Installing collected packages: jsonschema, functools32 14:07:31 INFO - Running setup.py install for functools32 14:07:31 INFO - warning: no files found matching '*.txt' 14:07:31 INFO - no previously-included directories found matching 'build' 14:07:31 INFO - no previously-included directories found matching 'dist' 14:07:31 INFO - no previously-included directories found matching '.git*' 14:07:31 INFO - Successfully installed jsonschema functools32 14:07:31 INFO - Cleaning up... 14:07:32 INFO - Return code: 0 14:07:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:07:32 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 0x7fe165b6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1348600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', '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 14:07:32 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 14:07:32 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 14:07:32 INFO - Using env: {'DISPLAY': ':0', 14:07:32 INFO - 'HOME': '/home/cltbld', 14:07:32 INFO - 'LANG': 'en_US.UTF-8', 14:07:32 INFO - 'LANGUAGE': 'en_US:en', 14:07:32 INFO - 'LOGNAME': 'cltbld', 14:07:32 INFO - 'MAIL': '/var/mail/cltbld', 14:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:32 INFO - 'MOZ_NO_REMOTE': '1', 14:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:32 INFO - 'NO_EM_RESTART': '1', 14:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:32 INFO - 'SHELL': '/bin/bash', 14:07:32 INFO - 'SHLVL': '1', 14:07:32 INFO - 'TERM': 'linux', 14:07:32 INFO - 'TMOUT': '86400', 14:07:32 INFO - 'USER': 'cltbld', 14:07:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:32 INFO - '_': '/tools/buildbot/bin/python'} 14:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:32 INFO - Downloading/unpacking flake8 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:07:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:07:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:34 INFO - no previously-included directories found matching 'docs/_build' 14:07:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:07:34 INFO - Running setup.py install for pep8 14:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:07:34 INFO - no previously-included directories found matching 'docs/_build' 14:07:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:07:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:07:34 INFO - Cleaning up... 14:07:34 INFO - Return code: 0 14:07:34 INFO - Running post-action listener: _resource_record_post_action 14:07:34 INFO - Running post-action listener: _start_resource_monitoring 14:07:34 INFO - Starting resource monitoring. 14:07:34 INFO - ##### 14:07:34 INFO - ##### Running install step. 14:07:34 INFO - ##### 14:07:34 INFO - Running pre-action listener: _resource_record_pre_action 14:07:34 INFO - Running main action method: install 14:07:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:07:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:07:35 INFO - Reading from file tmpfile_stdout 14:07:35 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:07:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:07:35 INFO - Reading from file tmpfile_stdout 14:07:35 INFO - Output received: 14:07:35 INFO - Usage: mozinstall [options] installer 14:07:35 INFO - Options: 14:07:35 INFO - -h, --help show this help message and exit 14:07:35 INFO - -d DEST, --destination=DEST 14:07:35 INFO - Directory to install application into. [default: 14:07:35 INFO - "/builds/slave/test-pgo"] 14:07:35 INFO - --app=APP Application being installed. [default: firefox] 14:07:35 INFO - mkdir: /builds/slave/test-pgo/build/application 14:07:35 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'] 14:07:35 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 14:07:49 INFO - Reading from file tmpfile_stdout 14:07:49 INFO - Output received: 14:07:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:07:49 INFO - Running post-action listener: _resource_record_post_action 14:07:49 INFO - ##### 14:07:49 INFO - ##### Running run-tests step. 14:07:49 INFO - ##### 14:07:49 INFO - Running pre-action listener: _resource_record_pre_action 14:07:49 INFO - Running main action method: run_tests 14:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:07:49 INFO - Python 2.7.3 14:07:49 INFO - Return code: 0 14:07:49 INFO - grabbing minidump binary from tooltool 14:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:49 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 0x13d7350>, '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 0x13d8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d86e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:07:49 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 14:07:49 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 14:07:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:49 INFO - Return code: 0 14:07:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:07:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:07:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:07:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:07:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:07:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:07:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:07:50 INFO - Return code: 0 14:07:50 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/1455219334/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:07:50 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/1455219334/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 14:07:50 INFO - Using env: {'DISPLAY': ':0', 14:07:50 INFO - 'HOME': '/home/cltbld', 14:07:50 INFO - 'LANG': 'en_US.UTF-8', 14:07:50 INFO - 'LANGUAGE': 'en_US:en', 14:07:50 INFO - 'LOGNAME': 'cltbld', 14:07:50 INFO - 'MAIL': '/var/mail/cltbld', 14:07:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:07:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:50 INFO - 'MOZ_NO_REMOTE': '1', 14:07:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:50 INFO - 'NO_EM_RESTART': '1', 14:07:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:07:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:07:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:07:50 INFO - 'SHELL': '/bin/bash', 14:07:50 INFO - 'SHLVL': '1', 14:07:50 INFO - 'TERM': 'linux', 14:07:50 INFO - 'TMOUT': '86400', 14:07:50 INFO - 'USER': 'cltbld', 14:07:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763', 14:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:50 INFO - '_': '/tools/buildbot/bin/python'} 14:07:50 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/1455219334/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 14:07:51 INFO - mozversion INFO | application_buildid: 20160211113534 14:07:51 INFO - mozversion INFO | application_changeset: fb1653512406a59fe283de17662b7b5d09c4128a 14:07:51 INFO - mozversion INFO | application_display_name: Nightly 14:07:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:51 INFO - mozversion INFO | application_name: Firefox 14:07:51 INFO - mozversion INFO | application_remotingname: firefox 14:07:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:51 INFO - mozversion INFO | application_vendor: Mozilla 14:07:51 INFO - mozversion INFO | application_version: 45.0 14:07:51 INFO - mozversion INFO | platform_buildid: 20160211113534 14:07:51 INFO - mozversion INFO | platform_changeset: fb1653512406a59fe283de17662b7b5d09c4128a 14:07:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:51 INFO - mozversion INFO | platform_version: 45.0 14:07:51 INFO - 2016-02-11 14:07:51,189 DEBUG : using testdate: 1455228471 14:07:51 INFO - 2016-02-11 14:07:51,189 DEBUG : actual date: 1455228471 14:07:51 INFO - 2016-02-11 14:07:51,198 INFO : starting webserver on 'localhost:58082' 14:07:51 INFO - 2016-02-11 14:07:51,199 INFO : Starting test suite talos-linux64-ix-019 14:07:51 INFO - 2016-02-11 14:07:51,199 INFO : Starting test dromaeo_css 14:07:51 INFO - 2016-02-11 14:07:51,199 DEBUG : operating with platform_type : linux_ 14:07:51 INFO - 2016-02-11 14:07:51,200 INFO : Initialising browser for dromaeo_css test... 14:07:51 INFO - 2016-02-11 14:07:51,216 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8lEWgx/profile http://localhost:58082/getInfo.html 14:07:55 INFO - 2016-02-11 14:07:55,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:07:55 INFO - 2016-02-11 14:07:55,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:07:55 INFO - 2016-02-11 14:07:55,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:07:55 INFO - 2016-02-11 14:07:55,077 DEBUG : BROWSER_OUTPUT: __metrics 14:07:55 INFO - 2016-02-11 14:07:55,321 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] 14:07:56 INFO - 2016-02-11 14:07:56,533 INFO : Browser initialized. 14:07:56 INFO - 2016-02-11 14:07:56,534 INFO : Running cycle 1/1 for dromaeo_css test... 14:07:56 INFO - 2016-02-11 14:07:56,534 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8lEWgx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:08:08 INFO - 2016-02-11 14:08:08,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 132292608 14:08:08 INFO - 2016-02-11 14:08:08,175 DEBUG : BROWSER_OUTPUT: 14:08:59 INFO - 2016-02-11 14:08:59,833 DEBUG : BROWSER_OUTPUT: 1455228539832 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] 14:11:07 INFO - 2016-02-11 14:11:07,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58082/tests/dromaeo/cssquery-ext.html) 14:11:08 INFO - 2016-02-11 14:11:08,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 242962432 14:11:08 INFO - 2016-02-11 14:11:08,130 DEBUG : BROWSER_OUTPUT: 14:14:10 INFO - 2016-02-11 14:14:10,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-ext.html (next: http://localhost:58082/tests/dromaeo/cssquery-jquery.html) 14:14:10 INFO - 2016-02-11 14:14:10,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 213921792 14:14:10 INFO - 2016-02-11 14:14:10,745 DEBUG : BROWSER_OUTPUT: 14:17:12 INFO - 2016-02-11 14:17:12,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58082/tests/dromaeo/cssquery-mootools.html) 14:17:13 INFO - 2016-02-11 14:17:13,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 211496960 14:17:13 INFO - 2016-02-11 14:17:13,060 DEBUG : BROWSER_OUTPUT: 14:20:14 INFO - 2016-02-11 14:20:14,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58082/tests/dromaeo/cssquery-prototype.html) 14:20:15 INFO - 2016-02-11 14:20:15,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 197292032 14:20:15 INFO - 2016-02-11 14:20:15,335 DEBUG : BROWSER_OUTPUT: 14:23:17 INFO - 2016-02-11 14:23:17,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58082/tests/dromaeo/cssquery-yui.html) 14:23:18 INFO - 2016-02-11 14:23:18,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 199983104 14:23:18 INFO - 2016-02-11 14:23:18,305 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/dromaeo/cssquery-yui.html (next: http://localhost:58082/tests/dromaeo/cssquery-dojo.html) 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 242786304 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3251.6260630027555;3254.41420544302;3270.836458177092;3271.231260653746;3297.9670203297974;5342.065138600744;5394.514493695567;5395.78416863325;5410.918836217455;5430.511253987141;5396.541293990015;5456.563474922006;5469.808556700516;5491.148871924858;5499.092649712803;4906.190478571031;4974.767834214219;5020.974895125538;5048.6465947383695;5067.721275329855;4954.3063971044085;5005.449400565934;5012.072766538184;5014.122528557488;5020.0963826511215;4908.8281910133155;4920.901581968358;4985.825496107637;4989.276554899538;5034.119029169899;5016.673916195436;5020.0963826511215;5040.369953755762;5047.545720885138;5080.187170052774;5025.597952163818;5040;5066.189409694468;5082.923756143661;5105.974470127663;5127.230915362688;5300.893982120375;5356.839294821161;5398.4871437213405;5425.294711687495;5766.106253530709;5792.9710351447975;5819.185314056035;5833.06670932653;5863.560232982501;5785.421457854223;5861.472467477947;5868.970655146697;5870.383609721003;5874.1776151338845;5305.230741542493;5371.060064488699;5463.180522921554;5609.943900561024;5651.6043876928225;5974.163617093611;5997.880042399128;6006.069059295816;6010.098485227251;6013.759449622054;5592.077307244341;5751.769929202785;5794.913076303858;5798.9130163047585;5815.9709201453725;5722.570807189478;5731.484166425042;5867.354590994987;5868.647881127146;5887.852803679943;5831.271091113611;5840.649561026352;5844.620099693507;5858.736356863951;5862.677552734641;5635.380108188096;5745.540356771448;5803.47768700819;5812.447817457335;5867.6772777497645;4455.420795296655;4489.034857505587;4499.392582001388;4499.617532509773;4502.819887204475;3965.306071437487;4038.6163314485075;4038.7778672172726;4042.555318914917;4048.230836141183;5611.877624475122;5629.802956896489;5633.380328163898;5635.520980716685;5637.830865073973;5938.2280303560265;5940.6435613863305;5943.435373639497;5945.137954996501;5951.9107213391835;5450.182472629137;5485.561155107582;5556.388797232301;5571.025070612626;5588.077967135378;5171.379434467888;5210.921836172384;5210.947890521122;5213.035588416155;5215.817446389434;5909.113632955091;6083.361247069082;6092.634441933498;6095.725692343855;6101.145839582462;5828.562857785599;5856.326522449973;5885.793997210077;5894.086416605433;5925.496332811759;6040.335563087969;6045.576809623284;6050.667213303311;6050.727717252822;6051.243594550681;5577.44225577439;5675.858103547444;5841.211436456024;5844.678542680023;5856.355800861987;5798.507126894261;5815.738291776795;5875.059990401515;5888.528917686661;5926.466618004228;5581.553475722014;5627.718614069362;5628.296462942132;5630.60585758993;5634.943650563442;5617.634853734494;5651.802186923438;5692.829215123553;5716.371199168171;5726.0838265877255;5683.9715801420725;5691.231683722644;5691.943080569141;5700.629459085312;5713.514351280188;5774.307083150049;5778.219940308005;5788.247527821356;5791.739371728367;5793.102069179284;5527.613067085265;5588.804391846266;5595.524380427546;5639.802606908738;5706.229658995982 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.3237250554322;612.4273803993264;612.4855121697778;613.834264748518;629.6945981199119;33665.83167084164;34455;34466.31067378651;34477;34477.82761086191;35926.281474370495;40216;41267;41272.793636031856;41352.58647413525;9126.406783559063;9299.349045566812;9299.907000930005;9304.906950930472;9305.674301399453;8539.1887770662;8753;9099.454032758056;9216.723498295061;9222.815543689123;11119.72200694985;11289.379084150369;11344.376059316734;11346.943265283704;11356.48895799691;10888.346699198033;10989.230753847234;11012.669619911336;11014.173936954761;11015.504302306375;10751;10858;10859.1312694985;10871.51078201475;10871.945640271828;44305.113897722185;44583.331250031275;44612;44742.55257447449;44862;3565.714742820568;3701.0932321581117;3721.0697325668584;4097.672186225095;4312.482502099768;33013.339733205445;33382.83308583441;33486.66513334884;33529;33648.663513364794;4138.296489596776;4173.5409104998425;4212.85255016076;4217.388478670576;4376.540463251376;294212;294770.52614737005;295880;296142;296503;59928.400715992284;61017.694911525155;71156;73879;73944;67181.66409167922;67257.66371168211;67399;67487.32512674811;67498.66250668715;14840.40638374453;14853.405863765545;14853.702925941421;14867.776983345258;14914.925425372803;12264.693382665504;12284.1401101922;12364.876351236553;12375.504979800888;12412.937935310265;21868.125274988823;22158;22348.44128896758;22352.329430117123;22358;7238.384737297389;7412.147603025721;7459.403247740168;7567.167611562723;7640.503367281109;994.3636072913341;1076.445630500293;1077.138289368502;1124.662601219631;1198.269055875915;30177.547336789965;30558.621338177294;30653.38693226123;30716.69283307183;31388;1079.1690398393193;1100.8458815765798;1113.209621168979;1148.1159507179425;1184.7867383870814;14010.789838152436;14440.783388249185;14606.05060671053;14633.634159146106;16026.439074632564;371227;371375;372562;374670;376333;58340.708296458244;58651.41348586459;58663;58676;58821;1302.4529697527062;1388.3752311459884;1468.9926550367393;1476.7268055409784;1499.475183685723;27935.860320698266;28601.141965741062;29294;29310.853445732635;30140.547891781203;46027.3095903555;46197.53802462067;46288.30567541557;46296.07407851891;46328.305075423224;249631;251315;251690;252056;252749;34212.657873421944;34565;34791.82604087065;34859.30281394409;34963.82518087495;46611;47860.28209576929;47960;48083;48470.27294590513;39660;39958.400623990085;40301.596984030955;40540.59459405486;40828.59171408367;38836.805815970736;40240;40449.59550404576;40940.79529602333;41131.7943410293;39465.210695786496;40049.79975100106;40359.3946090803;40646.39030414605;40757;35397.64602353943;36174.276514469035;36181.27637447289;36741.44887826738;36952.44571331486;27138.592921106596;27269.86365068162;27278.454430910875;27297.181084567495;27517 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.2236903823314;390.2818813383374;390.31694534564514;391.3269177015533;392.02581584761873;15055.473058442956;15843.84156158441;17074.317027318906;18442.723359149622;18460.538486537826;18331.45005649829;18391.172397242124;18717.532061698465;18770.81229187708;18829.52926176846;6218.160548325986;6334.714937827809;6337.778177763779;6359.968200158993;6369.108324834527;4595.2188128018315;4725.716457012573;6205.193324867783;6647.102641143432;6935;5213.2701421800975;6845.555038922479;6864.450843932474;6917.342852429037;6929.549579277331;5349.545288650469;5350.946490535084;5367.329083864517;5375.43557926418;5376.569874410038;5182.352205974254;5254.553362964152;5489.560835133179;5494.780208791643;5497.587680923907;20867.895660521754;21381.786182138134;21416;21621.45946351338;21845.344639660834;2185.2351676913113;2216.490207252341;2269.341890851651;2300.7354154272307;2389.6535002424725;9821.754456138653;10022.3485473444;10106.090451859294;10743.731406714816;14160.433582656682;1920.5774729559475;1937.0895679030832;1980.386080315107;2031.8272946799539;2049.067674208232;62575.6871215641;63075.684621577515;63627.363726363066;65229.67385163091;65355.346446535405;10400.427976461217;10636.30863993838;10703.357798532114;10762.461876906124;10780.353178809297;13889.166650001032;13990.93004534991;13999.860001399855;14029.78955315671;14034.578962631138;7904.881426778603;7924.207579242145;7970.1631328709655;8242.835143297101;8339.916600834036;7787.260210280015;7958.6418611162635;7967.442279040528;7998.000249968754;8005.279524842792;4145;4507.827964729194;4582.747948862844;4610.97694511532;4614.538546145359;1785.1520527749215;1801.675698374279;1829.3322937127853;1847.056192062027;1866.4587269691908;917.6833992272789;978.574320170728;984.5913945712592;999.1906555689915;1123.9715660170853;14997.475088371855;17046.318147274218;17168.22742976569;17349.479515614552;17396.565085872953;900.3074220465613;1000.6547741029333;1033.612395351743;1033.6640591807693;1036.6682661548382;9184.81630367389;9448.102430269113;9568.760780980392;9711.028897110375;10056.094951454405;682025.1797481962;685822;696615;700338;710185;85736;89175.55412222898;89971;90234.54882725545;90496;531.8484231993863;536.5975518361229;544.5561867078397;544.850166204297;545.1250742558137;9878.506074696093;9942.055504727039;10324.638637647646;10980.890191097988;11279.830802538132;37382;38218.426723599725;38240.80879595584;38916;38916.2216755669;50360.24459633182;51145.232821506965;52202;54016.72991635017;54127;10281.12610428122;10546.103581195684;10561.577536898745;10668.30656007357;10703.892961070289;14527;15281.235938203268;15329.540113796604;19389.51526211856;19406.514837129183;15019.924900375428;15210.16344101085;15224.695506089594;15452.84547154559;15975.520734377988;14747;14848.109113453227;15473.226338682796;15556.844431555539;15683.764743528627;15739;16253.187340633158;16303.26635301438;16694.749578756084;16715.164241787617;9892.554835032297;10069.043440873105;10121.797564048826;10123.848142277724;10148.441835699108;10356.067953884187;14494.637634059232;15510.224488775742;15536.92231538835;15790.842091578937 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1466.486729644624;1469.485680011996;1624.2447262023156;1771.3446024970763;1811.7282407638857;7468.327850493454;7882.251186137308;7884.211578842113;7887;7887.053553573572;7631.236876312366;7699.307062364386;7699.538027718327;7709.691612335514;7717.305442510173;2280.1905323610126;2284.565932472829;2318.4783423729696;2325.7790509901533;2326.2788535553946;2153.2894144932134;2155.8814265215406;2160.243914629875;2161.448830548216;2164.037003533428;1999.1503610965353;2029.8376129909573;2196.033745152136;2211.2039665720326;2249.4713742270637;2284.166279308049;2298.6552017197387;2313.849599776009;2313.9537209255805;2321.094773038508;2263.3549438409973;2328.627419612854;2329.3477826208687;2329.7553756855455;2331.2889568681544;6849.2808255132995;6913.965430172867;7509.774706758806;7619.733309334202;7627.771166865003;4603.332516785081;4646.163690535702;4714.198586240347;4717.221658426355;4719.95280047202;3085.861136248874;3099.364630250793;3135.623725152996;3153.668864769212;3196.2329041030216;1102.9779404411947;1111.4276147783899;1129.954801807935;1132.6885106595669;1145.3392580757852;10467.685969420929;10781.353118812896;10797.946010269978;10809.081228095543;10823.67528974124;4029.657479114308;4058.0869304406274;4066.2274167908004;4111.691623128278;4129.339305711072;9013.467710489233;9024.819503609891;9025.32310076747;9032.954835225783;9046.185843274137;4488.483824360175;4510.368548403226;4525.660575456854;4526.886827829265;4527.932081018787;4128.298189307825;4129.050318426718;4132.070284186034;4133.9793301033305;4135.234981528427;3425.880094196691;3453.171238902645;3455.2398472336045;3467.7052450541482;3481.5473988381855;966.3477152921749;973.6202880876464;981.259149342242;981.8723565936525;988.3526290279879;1383.8823699985412;1383.930803459823;1415.3489394878266;1417.3267697843648;1418.0569921002418;7127;7331.780046598504;7343.559386436831;7345.595992220372;7346.926530734624;470.3720533088297;474.55866044578875;474.65350294285366;478.2109519293194;481.90602832448036;5787.102999035156;6068.817935461943;6186.1648677428875;6186.969065154645;6188.597741146811;8192.877106843402;9114.680986165586;9195.862062069074;9215.078492150866;9225.031371705874;9007.729768106967;9072.092790721008;9106.908930910606;9119.772005699779;9129.178373946377;7503.09962804467;7548.471606987568;7603;7610.086789585174;7616.124145723313;7387.372073373824;7401.0748656417945;7473.327400533978;7481.551106933602;7483.88774168377;8186.099529051919;8369;8400.075991640793;8421.73673948888;8447;8407.747767566983;8435;8444;8447.831043379221;8678.175573320525;6924.376806087476;6993.230744617987;7030.437564994686;7036.2260151384335;7044.6125463100025;7675.385969122569;7768.650410731418;7787.5716835574585;7805.024371953506;7807.336376408069;7239.022731931122;7290.416766658761;7296.562206267641;7344.96327518359;7377.594232317274;7080.221175670775;7087.964560177373;7091.219965803654;7160.856782864418;7191.208967013729;7307.3058059484265;7351.117865856131;7360.411167106511;7372.741954031583;7383.446241532014;6465.482761379172;6587.934120658732;6750.527463077734;6806.76176333826;6825.795226143224;6922.550034247959;6935.271796461299;6945.305469453217;6982.581045137308;6986.755463558751 14:26:20 INFO - 2016-02-11 14:26:20,510 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.989950301491;341.91793969447326;344.7517787193221;352.487131224069;355.8399617247773;5975.462208401243;6024.48791852693;6065;6086.239220097488;6140.986737188364;5908.172855800191;5936.821895343136;6052.818415447533;6053.909191362133;6097.664628445434;4681.64887633428;4685.484596694361;4690.97654511727;4695.201815691341;4701.952980470202;4450.666200034994;4602.585767280944;4704.952950470502;4705.694129881546;4709.552592503724;4566.383538222331;4662.97668511657;4674.555917187879;4674.883127921795;4679.040796636698;4637.907241855144;4656.348111264426;4659.161350956826;4665.043666048452;4677.087967846272;4122.670186385112;4133.689973252018;4134.441850350195;4139.544650088488;4140.3375459926265;5576.828865938117;5761.971190144022;5763.6541807491685;5768.3366412862215;5796.449337312949;5399.136138217906;5414.377346605112;5417.51242388187;5420.051490989061;5423.942331245409;6466.482681385478;6474.838129046764;6475.902861457082;6479.708413121421;6482.67586620667;4301.763403012833;4352.455943007124;4400.823967041314;4444.488883778375;4452.243118669834;6646.83382915431;6687.063811066455;6699.866002679919;6701.899471507932;6705;4604.493505714368;4617.238155704271;4619.953800461953;4629.236176030917;4631.907361852744;4591.678582499193;4674.5325467452985;4676.95323046772;4680.485146633868;4683.929741053887;5420.24116623673;5421.295231619864;5431.6740995540395;5433.728313584305;5437.075697131497;6501.2198536175965;6503;6505.21937367519;6512.413882750575;6515.771947981798;1635.4848222809776;1649.9257533410785;1652.8347165283376;1653;1653.9338426463048;1099.367863478503;1105.6682995101437;1108.4790148630132;1125.3585456289836;1125.831125331207;6325.873482530324;6328.936710632835;6334.904976425358;6337.207849018872;6346.777862774781;6722.865542689119;6728.192616886005;6731.596104233664;6734.932650673529;6737;6215.254169499689;6260.40526150015;6323.430891219812;6331.27190373113;6337.176167098248;3628.165521929918;3648.835802388846;3668.669819716238;3672.1186915140706;3675.7610755301353;6940.7917762467205;6943.930560694328;6952.860942781217;6954.374106330353;6989.720411183597;6770.458363330922;6948.44412447003;6952.270011648805;6958.512904096665;6963.408110310579;6952.200496942815;6957.2694867038235;6957.9304206958295;6975.232724400312;6988.895166572505;6558.245801732862;6812.625305608239;6819.522633415613;6821.556598821259;6822.897656535255;6611.603303801788;6622.701978410887;6708.966455167693;6721.193456785217;6724.226713927766;6963.79108626742;6987.895181572178;7000.894986575104;7023.508354415142;7027.61348125858;4614.146382919171;4688.953110468851;4696.037312350892;4704.50602686713;4749.145153872336;6721.966390168018;6742.764003259862;6744.0895479109695;6789.15135608049;6800.455963522807;6589.27517973013;6605.966970165118;6610.702518386588;6615.6030638161865;6618.073469714148;6438.163038804925;6528.314526974599;6561.639109848813;6564.80305590833;6580.144581204413;6447.258565264867;6482.611043337415;6492.31830657793;6494.318096599789;6495.382938620824;6612.537122401386;6616.272210056986;6629.337066293332;6632.469402447696;6632.767853125118;6282.811515654537;6417.422431981144;6438.903416448663;6442.967785161044;6471.7734879279 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: |5;yui.html;849.9107593702661;891.6121487153093;927.8979312275646;955.9187469065129;963.6723514005237;14217.64455888602;14474.131552106881;14557.417703291856;14562;14575.344109515085;12484.750304993895;12766.744665106693;12773.425195866184;12775.552855650054;12787.552435664753;749.232037161908;760.4752720622753;892.2237653241656;894.8165626046645;922.3635691372965;894.2354287084546;915.3226612306878;920.9217216536603;924.2282693950559;925.8842644669417;940.2759874896326;953.2421724728857;956.8660387545749;962.4658314635375;964.3394274921701;775.7633921653893;789.3487872505177;923.7598224461622;953.7997020625677;956.5743244256308;698.5145323999823;705.9505834591529;710.3145464626608;711.654847399011;711.8505113926082;13499.25754083525;13544.119632223972;13612.523561675393;13625.659358516117;13783.379747911367;12628.810567841398;13481.393337299845;13510.189388636712;13620.591382258548;13714.725705485935;11188.720281992933;11300.604478843283;11368.431578421129;11451.370174640391;11558.653240402802;3633.6184700606586;3696.2977034363653;3698.8705395311035;3705.981470092659;3709.462127991453;52324.47675523234;52530.474695253324;53059.73470132663;53438.732806336106;53738;10023.949880250551;10147.644832430977;10192.337498062601;10754.085902698202;10915.235933484739;19694.507637308896;19695.113719882353;19702.113404896812;19714.40856774299;19743;7475.327220550176;7631.275028872248;7675.884861727079;7795.532268063821;8050.355971522265;4466.173757854743;4501.099780043939;4518.661100417482;4569.063342014879;4630;3191.2979144588153;3214.5499630051813;3215.710586047267;3217.8391080445886;3222.4199644063824;564.7402194990268;577.9739911703983;579.5884921705637;584.3163498706524;601.2334273800851;580.2563297291612;642.5084810120262;652.1598438799057;691.6852831961546;711.6655172069119;9053.954730226438;9133.49765762876;9294.581743821544;9427.19868811145;9533.809323813624;661.2329697550817;689.5655736885831;704.2675617357993;709.3403135084318;727.7962170592243;4466.486354069259;4641.234196357564;4681.157391669532;4840.443349014909;4870.09903167915;54091.45908540943;54311.18533222005;54523.18215226775;54542.72728636331;61360;55289;55708;55743.44256557382;55835.441645583836;56205.71897140488;50751.23873141832;50906;50999.235011474855;51302.230466543035;51371.48628513667;9489.66786162481;9693.563789629625;9771.706848794547;9924.206063515046;9939.950300248742;36417.45373819342;36688.81655591705;37244.44133337948;37362.8131859339;38219.2356152881;42455.575444245165;45304.320435192836;45988.77005614951;46607.53392466032;46824.063518730116;11567.710807229887;11940.283582985048;12389.442475088823;12596.307203103917;12614.432350544432;12679.112462127563;12893.548725794552;12996.220226786423;13091;13182.406791694588;11854.229475084438;11904.404779761151;12128.272303661455;12398.380080995734;12464.937675311565;11417.543298267976;11569.363684997406;12019;12067.57763478274;12098.75802483963;11815.76368472643;11956.34240116767;12019.158658893793;12200.084993625691;12297.385130743249;10546.894531054591;10766.192535560021;10859.945700271448;10907.236493445384;11115.166362522681;10062.597496100074;10401.791964160826;10413.53139108757;10454.477276136315;10509.31689440184 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,825 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: __startTimestamp1455229580502__endTimestamp 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5444.89 Median:5634.94 stddev:595.88 (10.6%) stddev-sans-first:572.33 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: Values: 3251.6 3254.4 3270.8 3271.2 3298.0 5342.1 5394.5 5395.8 5410.9 5430.5 5396.5 5456.6 5469.8 5491.1 5499.1 4906.2 4974.8 5021.0 5048.6 5067.7 4954.3 5005.4 5012.1 5014.1 5020.1 4908.8 4920.9 4985.8 4989.3 5034.1 5016.7 5020.1 5040.4 5047.5 5080.2 5025.6 5040.0 5066.2 5082.9 5106.0 5127.2 5300.9 5356.8 5398.5 5425.3 5766.1 5793.0 5819.2 5833.1 5863.6 5785.4 5861.5 5869.0 5870.4 5874.2 5305.2 5371.1 5463.2 5609.9 5651.6 5974.2 5997.9 6006.1 6010.1 6013.8 5592.1 5751.8 5794.9 5798.9 5816.0 5722.6 5731.5 5867.4 5868.6 5887.9 5831.3 5840.6 5844.6 5858.7 5862.7 5635.4 5745.5 5803.5 5812.4 5867.7 4455.4 4489.0 4499.4 4499.6 4502.8 3965.3 4038.6 4038.8 4042.6 4048.2 5611.9 5629.8 5633.4 5635.5 5637.8 5938.2 5940.6 5943.4 5945.1 5951.9 5450.2 5485.6 5556.4 5571.0 5588.1 5171.4 5210.9 5210.9 5213.0 5215.8 5909.1 6083.4 6092.6 6095.7 6101.1 5828.6 5856.3 5885.8 5894.1 5925.5 6040.3 6045.6 6050.7 6050.7 6051.2 5577.4 5675.9 5841.2 5844.7 5856.4 5798.5 5815.7 5875.1 5888.5 5926.5 5581.6 5627.7 5628.3 5630.6 5634.9 5617.6 5651.8 5692.8 5716.4 5726.1 5684.0 5691.2 5691.9 5700.6 5713.5 5774.3 5778.2 5788.2 5791.7 5793.1 5527.6 5588.8 5595.5 5639.8 5706.2 14:26:20 INFO - 2016-02-11 14:26:20,511 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49299.14 Median:19746.00 stddev:81357.29 (412.0%) stddev-sans-first:81503.20 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: Values: 554.3 612.4 612.5 613.8 629.7 33665.8 34455.0 34466.3 34477.0 34477.8 35926.3 40216.0 41267.0 41272.8 41352.6 9126.4 9299.3 9299.9 9304.9 9305.7 8539.2 8753.0 9099.5 9216.7 9222.8 11119.7 11289.4 11344.4 11346.9 11356.5 10888.3 10989.2 11012.7 11014.2 11015.5 10751.0 10858.0 10859.1 10871.5 10871.9 44305.1 44583.3 44612.0 44742.6 44862.0 3565.7 3701.1 3721.1 4097.7 4312.5 33013.3 33382.8 33486.7 33529.0 33648.7 4138.3 4173.5 4212.9 4217.4 4376.5 294212.0 294770.5 295880.0 296142.0 296503.0 59928.4 61017.7 71156.0 73879.0 73944.0 67181.7 67257.7 67399.0 67487.3 67498.7 14840.4 14853.4 14853.7 14867.8 14914.9 12264.7 12284.1 12364.9 12375.5 12412.9 21868.1 22158.0 22348.4 22352.3 22358.0 7238.4 7412.1 7459.4 7567.2 7640.5 994.4 1076.4 1077.1 1124.7 1198.3 30177.5 30558.6 30653.4 30716.7 31388.0 1079.2 1100.8 1113.2 1148.1 1184.8 14010.8 14440.8 14606.1 14633.6 16026.4 371227.0 371375.0 372562.0 374670.0 376333.0 58340.7 58651.4 58663.0 58676.0 58821.0 1302.5 1388.4 1469.0 1476.7 1499.5 27935.9 28601.1 29294.0 29310.9 30140.5 46027.3 46197.5 46288.3 46296.1 46328.3 249631.0 251315.0 251690.0 252056.0 252749.0 34212.7 34565.0 34791.8 34859.3 34963.8 46611.0 47860.3 47960.0 48083.0 48470.3 39660.0 39958.4 40301.6 40540.6 40828.6 38836.8 40240.0 40449.6 40940.8 41131.8 39465.2 40049.8 40359.4 40646.4 40757.0 35397.6 36174.3 36181.3 36741.4 36952.4 27138.6 27269.9 27278.5 27297.2 27517.0 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:34055.31 Median:2345.19 stddev:113529.56 (4840.9%) stddev-sans-first:113819.89 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: Values: 386.2 390.3 390.3 391.3 392.0 15055.5 15843.8 17074.3 18442.7 18460.5 18331.5 18391.2 18717.5 18770.8 18829.5 6218.2 6334.7 6337.8 6360.0 6369.1 4595.2 4725.7 6205.2 6647.1 6935.0 5213.3 6845.6 6864.5 6917.3 6929.5 5349.5 5350.9 5367.3 5375.4 5376.6 5182.4 5254.6 5489.6 5494.8 5497.6 20867.9 21381.8 21416.0 21621.5 21845.3 2185.2 2216.5 2269.3 2300.7 2389.7 9821.8 10022.3 10106.1 10743.7 14160.4 1920.6 1937.1 1980.4 2031.8 2049.1 62575.7 63075.7 63627.4 65229.7 65355.3 10400.4 10636.3 10703.4 10762.5 10780.4 13889.2 13990.9 13999.9 14029.8 14034.6 7904.9 7924.2 7970.2 8242.8 8339.9 7787.3 7958.6 7967.4 7998.0 8005.3 4145.0 4507.8 4582.7 4611.0 4614.5 1785.2 1801.7 1829.3 1847.1 1866.5 917.7 978.6 984.6 999.2 1124.0 14997.5 17046.3 17168.2 17349.5 17396.6 900.3 1000.7 1033.6 1033.7 1036.7 9184.8 9448.1 9568.8 9711.0 10056.1 682025.2 685822.0 696615.0 700338.0 710185.0 85736.0 89175.6 89971.0 90234.5 90496.0 531.8 536.6 544.6 544.9 545.1 9878.5 9942.1 10324.6 10980.9 11279.8 37382.0 38218.4 38240.8 38916.0 38916.2 50360.2 51145.2 52202.0 54016.7 54127.0 10281.1 10546.1 10561.6 10668.3 10703.9 14527.0 15281.2 15329.5 19389.5 19406.5 15019.9 15210.2 15224.7 15452.8 15975.5 14747.0 14848.1 15473.2 15556.8 15683.8 15739.0 16253.2 16303.3 16694.7 16715.2 9892.6 10069.0 10121.8 10123.8 10148.4 10356.1 14494.6 15510.2 15536.9 15790.8 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5470.20 Median:6881.62 stddev:2859.10 (41.5%) stddev-sans-first:2851.29 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: Values: 1466.5 1469.5 1624.2 1771.3 1811.7 7468.3 7882.3 7884.2 7887.0 7887.1 7631.2 7699.3 7699.5 7709.7 7717.3 2280.2 2284.6 2318.5 2325.8 2326.3 2153.3 2155.9 2160.2 2161.4 2164.0 1999.2 2029.8 2196.0 2211.2 2249.5 2284.2 2298.7 2313.8 2314.0 2321.1 2263.4 2328.6 2329.3 2329.8 2331.3 6849.3 6914.0 7509.8 7619.7 7627.8 4603.3 4646.2 4714.2 4717.2 4720.0 3085.9 3099.4 3135.6 3153.7 3196.2 1103.0 1111.4 1130.0 1132.7 1145.3 10467.7 10781.4 10797.9 10809.1 10823.7 4029.7 4058.1 4066.2 4111.7 4129.3 9013.5 9024.8 9025.3 9033.0 9046.2 4488.5 4510.4 4525.7 4526.9 4527.9 4128.3 4129.1 4132.1 4134.0 4135.2 3425.9 3453.2 3455.2 3467.7 3481.5 966.3 973.6 981.3 981.9 988.4 1383.9 1383.9 1415.3 1417.3 1418.1 7127.0 7331.8 7343.6 7345.6 7346.9 470.4 474.6 474.7 478.2 481.9 5787.1 6068.8 6186.2 6187.0 6188.6 8192.9 9114.7 9195.9 9215.1 9225.0 9007.7 9072.1 9106.9 9119.8 9129.2 7503.1 7548.5 7603.0 7610.1 7616.1 7387.4 7401.1 7473.3 7481.6 7483.9 8186.1 8369.0 8400.1 8421.7 8447.0 8407.7 8435.0 8444.0 8447.8 8678.2 6924.4 6993.2 7030.4 7036.2 7044.6 7675.4 7768.7 7787.6 7805.0 7807.3 7239.0 7290.4 7296.6 7345.0 7377.6 7080.2 7088.0 7091.2 7160.9 7191.2 7307.3 7351.1 7360.4 7372.7 7383.4 6465.5 6587.9 6750.5 6806.8 6825.8 6922.6 6935.3 6945.3 6982.6 6986.8 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5452.31 Median:6237.83 stddev:1649.48 (26.4%) stddev-sans-first:1608.77 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: Values: 335.0 341.9 344.8 352.5 355.8 5975.5 6024.5 6065.0 6086.2 6141.0 5908.2 5936.8 6052.8 6053.9 6097.7 4681.6 4685.5 4691.0 4695.2 4702.0 4450.7 4602.6 4705.0 4705.7 4709.6 4566.4 4663.0 4674.6 4674.9 4679.0 4637.9 4656.3 4659.2 4665.0 4677.1 4122.7 4133.7 4134.4 4139.5 4140.3 5576.8 5762.0 5763.7 5768.3 5796.4 5399.1 5414.4 5417.5 5420.1 5423.9 6466.5 6474.8 6475.9 6479.7 6482.7 4301.8 4352.5 4400.8 4444.5 4452.2 6646.8 6687.1 6699.9 6701.9 6705.0 4604.5 4617.2 4620.0 4629.2 4631.9 4591.7 4674.5 4677.0 4680.5 4683.9 5420.2 5421.3 5431.7 5433.7 5437.1 6501.2 6503.0 6505.2 6512.4 6515.8 1635.5 1649.9 1652.8 1653.0 1653.9 1099.4 1105.7 1108.5 1125.4 1125.8 6325.9 6328.9 6334.9 6337.2 6346.8 6722.9 6728.2 6731.6 6734.9 6737.0 6215.3 6260.4 6323.4 6331.3 6337.2 3628.2 3648.8 3668.7 3672.1 3675.8 6940.8 6943.9 6952.9 6954.4 6989.7 6770.5 6948.4 6952.3 6958.5 6963.4 6952.2 6957.3 6957.9 6975.2 6988.9 6558.2 6812.6 6819.5 6821.6 6822.9 6611.6 6622.7 6709.0 6721.2 6724.2 6963.8 6987.9 7000.9 7023.5 7027.6 4614.1 4689.0 4696.0 4704.5 4749.1 6722.0 6742.8 6744.1 6789.2 6800.5 6589.3 6606.0 6610.7 6615.6 6618.1 6438.2 6528.3 6561.6 6564.8 6580.1 6447.3 6482.6 6492.3 6494.3 6495.4 6612.5 6616.3 6629.3 6632.5 6632.8 6282.8 6417.4 6438.9 6443.0 6471.8 14:26:20 INFO - 2016-02-11 14:26:20,512 DEBUG : BROWSER_OUTPUT: 14:26:20 INFO - 2016-02-11 14:26:20,514 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14623.07 Median:24936.69 stddev:16754.90 (67.2%) stddev-sans-first:16769.98 14:26:20 INFO - 2016-02-11 14:26:20,514 DEBUG : BROWSER_OUTPUT: Values: 849.9 891.6 927.9 955.9 963.7 14217.6 14474.1 14557.4 14562.0 14575.3 12484.8 12766.7 12773.4 12775.6 12787.6 749.2 760.5 892.2 894.8 922.4 894.2 915.3 920.9 924.2 925.9 940.3 953.2 956.9 962.5 964.3 775.8 789.3 923.8 953.8 956.6 698.5 706.0 710.3 711.7 711.9 13499.3 13544.1 13612.5 13625.7 13783.4 12628.8 13481.4 13510.2 13620.6 13714.7 11188.7 11300.6 11368.4 11451.4 11558.7 3633.6 3696.3 3698.9 3706.0 3709.5 52324.5 52530.5 53059.7 53438.7 53738.0 10023.9 10147.6 10192.3 10754.1 10915.2 19694.5 19695.1 19702.1 19714.4 19743.0 7475.3 7631.3 7675.9 7795.5 8050.4 4466.2 4501.1 4518.7 4569.1 4630.0 3191.3 3214.5 3215.7 3217.8 3222.4 564.7 578.0 579.6 584.3 601.2 580.3 642.5 652.2 691.7 711.7 9054.0 9133.5 9294.6 9427.2 9533.8 661.2 689.6 704.3 709.3 727.8 4466.5 4641.2 4681.2 4840.4 4870.1 54091.5 54311.2 54523.2 54542.7 61360.0 55289.0 55708.0 55743.4 55835.4 56205.7 50751.2 50906.0 50999.2 51302.2 51371.5 9489.7 9693.6 9771.7 9924.2 9940.0 36417.5 36688.8 37244.4 37362.8 38219.2 42455.6 45304.3 45988.8 46607.5 46824.1 11567.7 11940.3 12389.4 12596.3 12614.4 12679.1 12893.5 12996.2 13091.0 13182.4 11854.2 11904.4 12128.3 12398.4 12464.9 11417.5 11569.4 12019.0 12067.6 12098.8 11815.8 11956.3 12019.2 12200.1 12297.4 10546.9 10766.2 10859.9 10907.2 11115.2 10062.6 10401.8 10413.5 10454.5 10509.3 14:26:20 INFO - 2016-02-11 14:26:20,514 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:26:20 INFO - 2016-02-11 14:26:20,514 DEBUG : BROWSER_OUTPUT: 14:26:21 INFO - 2016-02-11 14:26:21,094 INFO : Browser exited with error code: 0 14:26:21 INFO - 2016-02-11 14:26:21,112 INFO : Completed test dromaeo_css (00:18:29) 14:26:21 INFO - 2016-02-11 14:26:21,112 INFO : Starting test kraken 14:26:21 INFO - 2016-02-11 14:26:21,112 DEBUG : operating with platform_type : linux_ 14:26:21 INFO - 2016-02-11 14:26:21,112 INFO : Initialising browser for kraken test... 14:26:21 INFO - 2016-02-11 14:26:21,119 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLWj7Ur/profile http://localhost:58082/getInfo.html 14:26:25 INFO - 2016-02-11 14:26:25,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:26:25 INFO - 2016-02-11 14:26:25,132 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:26:25 INFO - 2016-02-11 14:26:25,132 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:26:25 INFO - 2016-02-11 14:26:25,132 DEBUG : BROWSER_OUTPUT: __metrics 14:26:25 INFO - 2016-02-11 14:26:25,317 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] 14:26:26 INFO - 2016-02-11 14:26:26,293 INFO : Browser initialized. 14:26:26 INFO - 2016-02-11 14:26:26,294 INFO : Running cycle 1/1 for kraken test... 14:26:26 INFO - 2016-02-11 14:26:26,294 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLWj7Ur/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:26:37 INFO - 2016-02-11 14:26:37,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 134397952 14:26:37 INFO - 2016-02-11 14:26:37,996 DEBUG : BROWSER_OUTPUT: 14:26:40 INFO - 2016-02-11 14:26:40,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58082/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:41 INFO - 2016-02-11 14:26:41,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 163729408 14:26:41 INFO - 2016-02-11 14:26:41,034 DEBUG : BROWSER_OUTPUT: 14:26:43 INFO - 2016-02-11 14:26:43,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58082/tests/kraken/driver.html?testName=audio-dft) 14:26:44 INFO - 2016-02-11 14:26:44,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 162148352 14:26:44 INFO - 2016-02-11 14:26:44,150 DEBUG : BROWSER_OUTPUT: 14:26:46 INFO - 2016-02-11 14:26:46,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58082/tests/kraken/driver.html?testName=audio-fft) 14:26:47 INFO - 2016-02-11 14:26:47,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 159506432 14:26:47 INFO - 2016-02-11 14:26:47,521 DEBUG : BROWSER_OUTPUT: 14:26:49 INFO - 2016-02-11 14:26:49,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58082/tests/kraken/driver.html?testName=audio-oscillator) 14:26:50 INFO - 2016-02-11 14:26:50,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 160583680 14:26:50 INFO - 2016-02-11 14:26:50,067 DEBUG : BROWSER_OUTPUT: 14:26:52 INFO - 2016-02-11 14:26:52,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:52 INFO - 2016-02-11 14:26:52,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 159698944 14:26:52 INFO - 2016-02-11 14:26:52,808 DEBUG : BROWSER_OUTPUT: 14:26:55 INFO - 2016-02-11 14:26:55,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58082/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:56 INFO - 2016-02-11 14:26:56,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 157986816 14:26:56 INFO - 2016-02-11 14:26:56,229 DEBUG : BROWSER_OUTPUT: 14:26:59 INFO - 2016-02-11 14:26:59,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58082/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:00 INFO - 2016-02-11 14:27:00,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 158408704 14:27:00 INFO - 2016-02-11 14:27:00,116 DEBUG : BROWSER_OUTPUT: 14:27:02 INFO - 2016-02-11 14:27:02,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58082/tests/kraken/driver.html?testName=json-parse-financial) 14:27:03 INFO - 2016-02-11 14:27:03,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 159449088 14:27:03 INFO - 2016-02-11 14:27:03,391 DEBUG : BROWSER_OUTPUT: 14:27:04 INFO - 2016-02-11 14:27:04,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:05 INFO - 2016-02-11 14:27:05,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 164405248 14:27:05 INFO - 2016-02-11 14:27:05,484 DEBUG : BROWSER_OUTPUT: 14:27:07 INFO - 2016-02-11 14:27:07,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:07 INFO - 2016-02-11 14:27:07,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 163139584 14:27:07 INFO - 2016-02-11 14:27:07,817 DEBUG : BROWSER_OUTPUT: 14:27:09 INFO - 2016-02-11 14:27:09,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:10 INFO - 2016-02-11 14:27:10,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 167006208 14:27:10 INFO - 2016-02-11 14:27:10,336 DEBUG : BROWSER_OUTPUT: 14:27:12 INFO - 2016-02-11 14:27:12,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:27:13 INFO - 2016-02-11 14:27:13,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 172130304 14:27:13 INFO - 2016-02-11 14:27:13,296 DEBUG : BROWSER_OUTPUT: 14:27:15 INFO - 2016-02-11 14:27:15,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:27:16 INFO - 2016-02-11 14:27:16,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 170209280 14:27:16 INFO - 2016-02-11 14:27:16,358 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58082/tests/kraken/driver.html?testName=ai-astar) 14:27:18 INFO - 2016-02-11 14:27:18,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 227491840 14:27:18 INFO - 2016-02-11 14:27:18,283 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,283 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:27:18 INFO - 2016-02-11 14:27:18,283 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;110;104;110;109;111;102;109;109;110 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;124;142;159;126;144;149;123;155;125 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;160;159;162;159;161;162;160 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;148;72;72;71;72;151;72 14:27:18 INFO - 2016-02-11 14:27:18,284 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;144;92;92;92;141;92;93;141 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;109;109 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;147;145;147;145;146;146;146 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;96;95;96;96 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;57;58;56;57;58;59;55;56 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;63;63;64;64;64;64;63 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;75;78;77;80;78;80;78;79;79;86 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;122;117;111;115;113;115;127;121;129 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;138;152;138;150;132;140;147;138;134 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;63;64;64;63;64;63;64;63;63 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:27:18 INFO - 2016-02-11 14:27:18,285 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:27:18 INFO - 2016-02-11 14:27:18,286 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,895 14:27:18 INFO - 2016-02-11 14:27:18,286 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:27:18 INFO - 2016-02-11 14:27:18,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1455229638282__endTimestamp 14:27:18 INFO - 2016-02-11 14:27:18,286 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:27:18 INFO - 2016-02-11 14:27:18,289 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:27:18 INFO - 2016-02-11 14:27:18,289 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,289 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.03 (2.8%) stddev-sans-first:3.07 14:27:18 INFO - 2016-02-11 14:27:18,289 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 104.0 110.0 109.0 111.0 102.0 109.0 109.0 110.0 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.20 Median:144.50 stddev:13.63 (9.4%) stddev-sans-first:14.29 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: Values: 145.0 124.0 142.0 159.0 126.0 144.0 149.0 123.0 155.0 125.0 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 160.0 159.0 162.0 159.0 161.0 162.0 160.0 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:72.00 stddev:32.69 (45.4%) stddev-sans-first:34.19 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 148.0 72.0 72.0 71.0 72.0 151.0 72.0 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:92.00 stddev:24.03 (26.1%) stddev-sans-first:24.85 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 144.0 92.0 92.0 92.0 141.0 92.0 93.0 141.0 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,290 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 147.0 145.0 147.0 145.0 146.0 146.0 146.0 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.27 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 57.0 58.0 56.0 57.0 58.0 59.0 55.0 56.0 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 63.0 63.0 64.0 64.0 64.0 64.0 63.0 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,291 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.87 (3.6%) stddev-sans-first:2.65 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: Values: 75.0 78.0 77.0 80.0 78.0 80.0 78.0 79.0 79.0 86.0 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.00 stddev:5.93 (5.0%) stddev-sans-first:6.25 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: Values: 117.0 122.0 117.0 111.0 115.0 113.0 115.0 127.0 121.0 129.0 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.80 Median:139.50 stddev:6.66 (4.8%) stddev-sans-first:7.04 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: Values: 139.0 138.0 152.0 138.0 150.0 132.0 140.0 147.0 138.0 134.0 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.75 (4.3%) stddev-sans-first:0.53 14:27:18 INFO - 2016-02-11 14:27:18,292 DEBUG : BROWSER_OUTPUT: Values: 72.0 63.0 64.0 64.0 63.0 64.0 63.0 64.0 63.0 63.0 14:27:18 INFO - 2016-02-11 14:27:18,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:27:18 INFO - 2016-02-11 14:27:18,293 DEBUG : BROWSER_OUTPUT: 14:27:18 INFO - 2016-02-11 14:27:18,942 INFO : Browser exited with error code: 0 14:27:18 INFO - 2016-02-11 14:27:18,995 INFO : Completed test kraken (00:00:57) 14:27:18 INFO - 2016-02-11 14:27:18,995 INFO : Starting test v8_7 14:27:18 INFO - 2016-02-11 14:27:18,995 DEBUG : operating with platform_type : linux_ 14:27:18 INFO - 2016-02-11 14:27:18,995 INFO : Initialising browser for v8_7 test... 14:27:19 INFO - 2016-02-11 14:27:19,002 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdml5pL/profile http://localhost:58082/getInfo.html 14:27:22 INFO - 2016-02-11 14:27:22,961 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:27:22 INFO - 2016-02-11 14:27:22,961 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:27:22 INFO - 2016-02-11 14:27:22,961 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:27:22 INFO - 2016-02-11 14:27:22,962 DEBUG : BROWSER_OUTPUT: __metrics 14:27:23 INFO - 2016-02-11 14:27:23,244 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] 14:27:24 INFO - 2016-02-11 14:27:24,289 INFO : Browser initialized. 14:27:24 INFO - 2016-02-11 14:27:24,290 INFO : Running cycle 1/1 for v8_7 test... 14:27:24 INFO - 2016-02-11 14:27:24,290 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdml5pL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:27:35 INFO - 2016-02-11 14:27:35,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 134393856 14:27:35 INFO - 2016-02-11 14:27:35,937 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58082/tests/v8_7/run.html (next: http://localhost:58082/tests/v8_7/run.html) 14:27:57 INFO - 2016-02-11 14:27:57,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 422510592 14:27:57 INFO - 2016-02-11 14:27:57,544 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,544 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:27:57 INFO - 2016-02-11 14:27:57,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:27:57 INFO - 2016-02-11 14:27:57,545 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:27:57 INFO - 2016-02-11 14:27:57,545 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:27:57 INFO - 2016-02-11 14:27:57,545 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7570877369569 14:27:57 INFO - 2016-02-11 14:27:57,545 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.6090534979424 14:27:57 INFO - 2016-02-11 14:27:57,545 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 14:27:57 INFO - 2016-02-11 14:27:57,546 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5153.846153846154 14:27:57 INFO - 2016-02-11 14:27:57,546 DEBUG : BROWSER_OUTPUT: |4;RayTrace;960.6147934678194 14:27:57 INFO - 2016-02-11 14:27:57,546 DEBUG : BROWSER_OUTPUT: |5;Earley;546.7468562055768 14:27:57 INFO - 2016-02-11 14:27:57,546 DEBUG : BROWSER_OUTPUT: |6;Boyer;10600 14:27:57 INFO - 2016-02-11 14:27:57,546 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: |8;Splay;520.5622071837585 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1455229677542__endTimestamp 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.76 Median:167.76 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: Values: 167.8 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,548 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.61 Median:164.61 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,549 DEBUG : BROWSER_OUTPUT: Values: 164.6 14:27:57 INFO - 2016-02-11 14:27:57,549 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,549 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,549 DEBUG : BROWSER_OUTPUT: Values: 277.6 14:27:57 INFO - 2016-02-11 14:27:57,550 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,550 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5153.85 Median:5153.85 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,550 DEBUG : BROWSER_OUTPUT: Values: 5153.8 14:27:57 INFO - 2016-02-11 14:27:57,550 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:960.61 Median:960.61 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: Values: 960.6 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.75 Median:546.75 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: Values: 546.7 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10600.00 Median:10600.00 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: Values: 10600.0 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: Values: 24238.1 14:27:57 INFO - 2016-02-11 14:27:57,551 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,552 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:520.56 Median:520.56 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,552 DEBUG : BROWSER_OUTPUT: Values: 520.6 14:27:57 INFO - 2016-02-11 14:27:57,552 DEBUG : BROWSER_OUTPUT: 14:27:57 INFO - 2016-02-11 14:27:57,552 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 14:27:57 INFO - 2016-02-11 14:27:57,553 DEBUG : BROWSER_OUTPUT: Values: 4840.6 14:27:57 INFO - 2016-02-11 14:27:57,553 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:27:57 INFO - 2016-02-11 14:27:57,553 DEBUG : BROWSER_OUTPUT: 14:27:58 INFO - 2016-02-11 14:27:58,270 INFO : Browser exited with error code: 0 14:27:58 INFO - 2016-02-11 14:27:58,284 INFO : Completed test v8_7 (00:00:39) 14:27:58 INFO - 2016-02-11 14:27:58,560 INFO : Completed test suite (00:20:07) 14:27:58 INFO - 2016-02-11 14:27:58,560 DEBUG : Working with test: dromaeo_css 14:27:58 INFO - 2016-02-11 14:27:58,561 DEBUG : Generating results file: dromaeo_css 14:27:58 INFO - 2016-02-11 14:27:58,562 DEBUG : Working with test: kraken 14:27:58 INFO - 2016-02-11 14:27:58,562 DEBUG : Generating results file: kraken 14:27:58 INFO - 2016-02-11 14:27:58,563 INFO : javascript benchmark 14:27:58 INFO - 2016-02-11 14:27:58,563 DEBUG : Working with test: v8_7 14:27:58 INFO - 2016-02-11 14:27:58,563 DEBUG : Generating results file: v8_7 14:27:58 INFO - 2016-02-11 14:27:58,564 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:27:58 INFO - 2016-02-11 14:27:58,616 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:27:58 INFO - 2016-02-11 14:27:58,616 DEBUG : process_Request line: dromaeo_css 7247.87 graph.html#tests=[[72,53,35]] 14:27:58 INFO - 2016-02-11 14:27:58,616 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:27:58 INFO - 2016-02-11 14:27:58,650 DEBUG : process_Request line: kraken 1476.00 graph.html#tests=[[232,53,35]] 14:27:58 INFO - 2016-02-11 14:27:58,650 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:27:58 INFO - 2016-02-11 14:27:58,679 DEBUG : process_Request line: v8_7 23257.96 graph.html#tests=[[230,53,35]] 14:27:58 INFO - 2016-02-11 14:27:58,680 INFO : javascript benchmark 14:27:58 INFO - 2016-02-11 14:27:58,683 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3251.6260630027555, 3254.41420544302, 3270.836458177092, 3271.231260653746, 3297.9670203297974, 5342.065138600744, 5394.514493695567, 5395.78416863325, 5410.918836217455, 5430.511253987141, 5396.541293990015, 5456.563474922006, 5469.808556700516, 5491.148871924858, 5499.092649712803, 4906.190478571031, 4974.767834214219, 5020.974895125538, 5048.6465947383695, 5067.721275329855, 4954.3063971044085, 5005.449400565934, 5012.072766538184, 5014.122528557488, 5020.0963826511215, 4908.8281910133155, 4920.901581968358, 4985.825496107637, 4989.276554899538, 5034.119029169899, 5016.673916195436, 5020.0963826511215, 5040.369953755762, 5047.545720885138, 5080.187170052774, 5025.597952163818, 5040.0, 5066.189409694468, 5082.923756143661, 5105.974470127663, 5127.230915362688, 5300.893982120375, 5356.839294821161, 5398.4871437213405, 5425.294711687495, 5766.106253530709, 5792.9710351447975, 5819.185314056035, 5833.06670932653, 5863.560232982501, 5785.421457854223, 5861.472467477947, 5868.970655146697, 5870.383609721003, 5874.1776151338845, 5305.230741542493, 5371.060064488699, 5463.180522921554, 5609.943900561024, 5651.6043876928225, 5974.163617093611, 5997.880042399128, 6006.069059295816, 6010.098485227251, 6013.759449622054, 5592.077307244341, 5751.769929202785, 5794.913076303858, 5798.9130163047585, 5815.9709201453725, 5722.570807189478, 5731.484166425042, 5867.354590994987, 5868.647881127146, 5887.852803679943, 5831.271091113611, 5840.649561026352, 5844.620099693507, 5858.736356863951, 5862.677552734641, 5635.380108188096, 5745.540356771448, 5803.47768700819, 5812.447817457335, 5867.6772777497645, 4455.420795296655, 4489.034857505587, 4499.392582001388, 4499.617532509773, 4502.819887204475, 3965.306071437487, 4038.6163314485075, 4038.7778672172726, 4042.555318914917, 4048.230836141183, 5611.877624475122, 5629.802956896489, 5633.380328163898, 5635.520980716685, 5637.830865073973, 5938.2280303560265, 5940.6435613863305, 5943.435373639497, 5945.137954996501, 5951.9107213391835, 5450.182472629137, 5485.561155107582, 5556.388797232301, 5571.025070612626, 5588.077967135378, 5171.379434467888, 5210.921836172384, 5210.947890521122, 5213.035588416155, 5215.817446389434, 5909.113632955091, 6083.361247069082, 6092.634441933498, 6095.725692343855, 6101.145839582462, 5828.562857785599, 5856.326522449973, 5885.793997210077, 5894.086416605433, 5925.496332811759, 6040.335563087969, 6045.576809623284, 6050.667213303311, 6050.727717252822, 6051.243594550681, 5577.44225577439, 5675.858103547444, 5841.211436456024, 5844.678542680023, 5856.355800861987, 5798.507126894261, 5815.738291776795, 5875.059990401515, 5888.528917686661, 5926.466618004228, 5581.553475722014, 5627.718614069362, 5628.296462942132, 5630.60585758993, 5634.943650563442, 5617.634853734494, 5651.802186923438, 5692.829215123553, 5716.371199168171, 5726.0838265877255, 5683.9715801420725, 5691.231683722644, 5691.943080569141, 5700.629459085312, 5713.514351280188, 5774.307083150049, 5778.219940308005, 5788.247527821356, 5791.739371728367, 5793.102069179284, 5527.613067085265, 5588.804391846266, 5595.524380427546, 5639.802606908738, 5706.229658995982], "unit": "ms", "name": "dojo.html", "value": 5406.526895934842}, {"lowerIsBetter": false, "replicates": [554.3237250554322, 612.4273803993264, 612.4855121697778, 613.834264748518, 629.6945981199119, 33665.83167084164, 34455.0, 34466.31067378651, 34477.0, 34477.82761086191, 35926.281474370495, 40216.0, 41267.0, 41272.793636031856, 41352.58647413525, 9126.406783559063, 9299.349045566812, 9299.907000930005, 9304.906950930472, 9305.674301399453, 8539.1887770662, 8753.0, 9099.454032758056, 9216.723498295061, 9222.815543689123, 11119.72200694985, 11289.379084150369, 11344.376059316734, 11346.943265283704, 11356.48895799691, 10888.346699198033, 10989.230753847234, 11012.669619911336, 11014.173936954761, 11015.504302306375, 10751.0, 10858.0, 10859.1312694985, 10871.51078201475, 10871.945640271828, 44305.113897722185, 44583.331250031275, 44612.0, 44742.55257447449, 44862.0, 3565.714742820568, 3701.0932321581117, 3721.0697325668584, 4097.672186225095, 4312.482502099768, 33013.339733205445, 33382.83308583441, 33486.66513334884, 33529.0, 33648.663513364794, 4138.296489596776, 4173.5409104998425, 4212.85255016076, 4217.388478670576, 4376.540463251376, 294212.0, 294770.52614737005, 295880.0, 296142.0, 296503.0, 59928.400715992284, 61017.694911525155, 71156.0, 73879.0, 73944.0, 67181.66409167922, 67257.66371168211, 67399.0, 67487.32512674811, 67498.66250668715, 14840.40638374453, 14853.405863765545, 14853.702925941421, 14867.776983345258, 14914.925425372803, 12264.693382665504, 12284.1401101922, 12364.876351236553, 12375.504979800888, 12412.937935310265, 21868.125274988823, 22158.0, 22348.44128896758, 22352.329430117123, 22358.0, 7238.384737297389, 7412.147603025721, 7459.403247740168, 7567.167611562723, 7640.503367281109, 994.3636072913341, 1076.445630500293, 1077.138289368502, 1124.662601219631, 1198.269055875915, 30177.547336789965, 30558.621338177294, 30653.38693226123, 30716.69283307183, 31388.0, 1079.1690398393193, 1100.8458815765798, 1113.209621168979, 1148.1159507179425, 1184.7867383870814, 14010.789838152436, 14440.783388249185, 14606.05060671053, 14633.634159146106, 16026.439074632564, 371227.0, 371375.0, 372562.0, 374670.0, 376333.0, 58340.708296458244, 58651.41348586459, 58663.0, 58676.0, 58821.0, 1302.4529697527062, 1388.3752311459884, 1468.9926550367393, 1476.7268055409784, 1499.475183685723, 27935.860320698266, 28601.141965741062, 29294.0, 29310.853445732635, 30140.547891781203, 46027.3095903555, 46197.53802462067, 46288.30567541557, 46296.07407851891, 46328.305075423224, 249631.0, 251315.0, 251690.0, 252056.0, 252749.0, 34212.657873421944, 34565.0, 34791.82604087065, 34859.30281394409, 34963.82518087495, 46611.0, 47860.28209576929, 47960.0, 48083.0, 48470.27294590513, 39660.0, 39958.400623990085, 40301.596984030955, 40540.59459405486, 40828.59171408367, 38836.805815970736, 40240.0, 40449.59550404576, 40940.79529602333, 41131.7943410293, 39465.210695786496, 40049.79975100106, 40359.3946090803, 40646.39030414605, 40757.0, 35397.64602353943, 36174.276514469035, 36181.27637447289, 36741.44887826738, 36952.44571331486, 27138.592921106596, 27269.86365068162, 27278.454430910875, 27297.181084567495, 27517.0], "unit": "ms", "name": "ext.html", "value": 19916.10704327077}, {"lowerIsBetter": false, "replicates": [386.2236903823314, 390.2818813383374, 390.31694534564514, 391.3269177015533, 392.02581584761873, 15055.473058442956, 15843.84156158441, 17074.317027318906, 18442.723359149622, 18460.538486537826, 18331.45005649829, 18391.172397242124, 18717.532061698465, 18770.81229187708, 18829.52926176846, 6218.160548325986, 6334.714937827809, 6337.778177763779, 6359.968200158993, 6369.108324834527, 4595.2188128018315, 4725.716457012573, 6205.193324867783, 6647.102641143432, 6935.0, 5213.2701421800975, 6845.555038922479, 6864.450843932474, 6917.342852429037, 6929.549579277331, 5349.545288650469, 5350.946490535084, 5367.329083864517, 5375.43557926418, 5376.569874410038, 5182.352205974254, 5254.553362964152, 5489.560835133179, 5494.780208791643, 5497.587680923907, 20867.895660521754, 21381.786182138134, 21416.0, 21621.45946351338, 21845.344639660834, 2185.2351676913113, 2216.490207252341, 2269.341890851651, 2300.7354154272307, 2389.6535002424725, 9821.754456138653, 10022.3485473444, 10106.090451859294, 10743.731406714816, 14160.433582656682, 1920.5774729559475, 1937.0895679030832, 1980.386080315107, 2031.8272946799539, 2049.067674208232, 62575.6871215641, 63075.684621577515, 63627.363726363066, 65229.67385163091, 65355.346446535405, 10400.427976461217, 10636.30863993838, 10703.357798532114, 10762.461876906124, 10780.353178809297, 13889.166650001032, 13990.93004534991, 13999.860001399855, 14029.78955315671, 14034.578962631138, 7904.881426778603, 7924.207579242145, 7970.1631328709655, 8242.835143297101, 8339.916600834036, 7787.260210280015, 7958.6418611162635, 7967.442279040528, 7998.000249968754, 8005.279524842792, 4145.0, 4507.827964729194, 4582.747948862844, 4610.97694511532, 4614.538546145359, 1785.1520527749215, 1801.675698374279, 1829.3322937127853, 1847.056192062027, 1866.4587269691908, 917.6833992272789, 978.574320170728, 984.5913945712592, 999.1906555689915, 1123.9715660170853, 14997.475088371855, 17046.318147274218, 17168.22742976569, 17349.479515614552, 17396.565085872953, 900.3074220465613, 1000.6547741029333, 1033.612395351743, 1033.6640591807693, 1036.6682661548382, 9184.81630367389, 9448.102430269113, 9568.760780980392, 9711.028897110375, 10056.094951454405, 682025.1797481962, 685822.0, 696615.0, 700338.0, 710185.0, 85736.0, 89175.55412222898, 89971.0, 90234.54882725545, 90496.0, 531.8484231993863, 536.5975518361229, 544.5561867078397, 544.850166204297, 545.1250742558137, 9878.506074696093, 9942.055504727039, 10324.638637647646, 10980.890191097988, 11279.830802538132, 37382.0, 38218.426723599725, 38240.80879595584, 38916.0, 38916.2216755669, 50360.24459633182, 51145.232821506965, 52202.0, 54016.72991635017, 54127.0, 10281.12610428122, 10546.103581195684, 10561.577536898745, 10668.30656007357, 10703.892961070289, 14527.0, 15281.235938203268, 15329.540113796604, 19389.51526211856, 19406.514837129183, 15019.924900375428, 15210.16344101085, 15224.695506089594, 15452.84547154559, 15975.520734377988, 14747.0, 14848.109113453227, 15473.226338682796, 15556.844431555539, 15683.764743528627, 15739.0, 16253.187340633158, 16303.26635301438, 16694.749578756084, 16715.164241787617, 9892.554835032297, 10069.043440873105, 10121.797564048826, 10123.848142277724, 10148.441835699108, 10356.067953884187, 14494.637634059232, 15510.224488775742, 15536.92231538835, 15790.842091578937], "unit": "ms", "name": "jquery.html", "value": 9207.859558602844}, {"lowerIsBetter": false, "replicates": [1466.486729644624, 1469.485680011996, 1624.2447262023156, 1771.3446024970763, 1811.7282407638857, 7468.327850493454, 7882.251186137308, 7884.211578842113, 7887.0, 7887.053553573572, 7631.236876312366, 7699.307062364386, 7699.538027718327, 7709.691612335514, 7717.305442510173, 2280.1905323610126, 2284.565932472829, 2318.4783423729696, 2325.7790509901533, 2326.2788535553946, 2153.2894144932134, 2155.8814265215406, 2160.243914629875, 2161.448830548216, 2164.037003533428, 1999.1503610965353, 2029.8376129909573, 2196.033745152136, 2211.2039665720326, 2249.4713742270637, 2284.166279308049, 2298.6552017197387, 2313.849599776009, 2313.9537209255805, 2321.094773038508, 2263.3549438409973, 2328.627419612854, 2329.3477826208687, 2329.7553756855455, 2331.2889568681544, 6849.2808255132995, 6913.965430172867, 7509.774706758806, 7619.733309334202, 7627.771166865003, 4603.332516785081, 4646.163690535702, 4714.198586240347, 4717.221658426355, 4719.95280047202, 3085.861136248874, 3099.364630250793, 3135.623725152996, 3153.668864769212, 3196.2329041030216, 1102.9779404411947, 1111.4276147783899, 1129.954801807935, 1132.6885106595669, 1145.3392580757852, 10467.685969420929, 10781.353118812896, 10797.946010269978, 10809.081228095543, 10823.67528974124, 4029.657479114308, 4058.0869304406274, 4066.2274167908004, 4111.691623128278, 4129.339305711072, 9013.467710489233, 9024.819503609891, 9025.32310076747, 9032.954835225783, 9046.185843274137, 4488.483824360175, 4510.368548403226, 4525.660575456854, 4526.886827829265, 4527.932081018787, 4128.298189307825, 4129.050318426718, 4132.070284186034, 4133.9793301033305, 4135.234981528427, 3425.880094196691, 3453.171238902645, 3455.2398472336045, 3467.7052450541482, 3481.5473988381855, 966.3477152921749, 973.6202880876464, 981.259149342242, 981.8723565936525, 988.3526290279879, 1383.8823699985412, 1383.930803459823, 1415.3489394878266, 1417.3267697843648, 1418.0569921002418, 7127.0, 7331.780046598504, 7343.559386436831, 7345.595992220372, 7346.926530734624, 470.3720533088297, 474.55866044578875, 474.65350294285366, 478.2109519293194, 481.90602832448036, 5787.102999035156, 6068.817935461943, 6186.1648677428875, 6186.969065154645, 6188.597741146811, 8192.877106843402, 9114.680986165586, 9195.862062069074, 9215.078492150866, 9225.031371705874, 9007.729768106967, 9072.092790721008, 9106.908930910606, 9119.772005699779, 9129.178373946377, 7503.09962804467, 7548.471606987568, 7603.0, 7610.086789585174, 7616.124145723313, 7387.372073373824, 7401.0748656417945, 7473.327400533978, 7481.551106933602, 7483.88774168377, 8186.099529051919, 8369.0, 8400.075991640793, 8421.73673948888, 8447.0, 8407.747767566983, 8435.0, 8444.0, 8447.831043379221, 8678.175573320525, 6924.376806087476, 6993.230744617987, 7030.437564994686, 7036.2260151384335, 7044.6125463100025, 7675.385969122569, 7768.650410731418, 7787.5716835574585, 7805.024371953506, 7807.336376408069, 7239.022731931122, 7290.416766658761, 7296.562206267641, 7344.96327518359, 7377.594232317274, 7080.221175670775, 7087.964560177373, 7091.219965803654, 7160.856782864418, 7191.208967013729, 7307.3058059484265, 7351.117865856131, 7360.411167106511, 7372.741954031583, 7383.446241532014, 6465.482761379172, 6587.934120658732, 6750.527463077734, 6806.76176333826, 6825.795226143224, 6922.550034247959, 6935.271796461299, 6945.305469453217, 6982.581045137308, 6986.755463558751], "unit": "ms", "name": "mootools.html", "value": 4409.352182749876}, {"lowerIsBetter": false, "replicates": [334.989950301491, 341.91793969447326, 344.7517787193221, 352.487131224069, 355.8399617247773, 5975.462208401243, 6024.48791852693, 6065.0, 6086.239220097488, 6140.986737188364, 5908.172855800191, 5936.821895343136, 6052.818415447533, 6053.909191362133, 6097.664628445434, 4681.64887633428, 4685.484596694361, 4690.97654511727, 4695.201815691341, 4701.952980470202, 4450.666200034994, 4602.585767280944, 4704.952950470502, 4705.694129881546, 4709.552592503724, 4566.383538222331, 4662.97668511657, 4674.555917187879, 4674.883127921795, 4679.040796636698, 4637.907241855144, 4656.348111264426, 4659.161350956826, 4665.043666048452, 4677.087967846272, 4122.670186385112, 4133.689973252018, 4134.441850350195, 4139.544650088488, 4140.3375459926265, 5576.828865938117, 5761.971190144022, 5763.6541807491685, 5768.3366412862215, 5796.449337312949, 5399.136138217906, 5414.377346605112, 5417.51242388187, 5420.051490989061, 5423.942331245409, 6466.482681385478, 6474.838129046764, 6475.902861457082, 6479.708413121421, 6482.67586620667, 4301.763403012833, 4352.455943007124, 4400.823967041314, 4444.488883778375, 4452.243118669834, 6646.83382915431, 6687.063811066455, 6699.866002679919, 6701.899471507932, 6705.0, 4604.493505714368, 4617.238155704271, 4619.953800461953, 4629.236176030917, 4631.907361852744, 4591.678582499193, 4674.5325467452985, 4676.95323046772, 4680.485146633868, 4683.929741053887, 5420.24116623673, 5421.295231619864, 5431.6740995540395, 5433.728313584305, 5437.075697131497, 6501.2198536175965, 6503.0, 6505.21937367519, 6512.413882750575, 6515.771947981798, 1635.4848222809776, 1649.9257533410785, 1652.8347165283376, 1653.0, 1653.9338426463048, 1099.367863478503, 1105.6682995101437, 1108.4790148630132, 1125.3585456289836, 1125.831125331207, 6325.873482530324, 6328.936710632835, 6334.904976425358, 6337.207849018872, 6346.777862774781, 6722.865542689119, 6728.192616886005, 6731.596104233664, 6734.932650673529, 6737.0, 6215.254169499689, 6260.40526150015, 6323.430891219812, 6331.27190373113, 6337.176167098248, 3628.165521929918, 3648.835802388846, 3668.669819716238, 3672.1186915140706, 3675.7610755301353, 6940.7917762467205, 6943.930560694328, 6952.860942781217, 6954.374106330353, 6989.720411183597, 6770.458363330922, 6948.44412447003, 6952.270011648805, 6958.512904096665, 6963.408110310579, 6952.200496942815, 6957.2694867038235, 6957.9304206958295, 6975.232724400312, 6988.895166572505, 6558.245801732862, 6812.625305608239, 6819.522633415613, 6821.556598821259, 6822.897656535255, 6611.603303801788, 6622.701978410887, 6708.966455167693, 6721.193456785217, 6724.226713927766, 6963.79108626742, 6987.895181572178, 7000.894986575104, 7023.508354415142, 7027.61348125858, 4614.146382919171, 4688.953110468851, 4696.037312350892, 4704.50602686713, 4749.145153872336, 6721.966390168018, 6742.764003259862, 6744.0895479109695, 6789.15135608049, 6800.455963522807, 6589.27517973013, 6605.966970165118, 6610.702518386588, 6615.6030638161865, 6618.073469714148, 6438.163038804925, 6528.314526974599, 6561.639109848813, 6564.80305590833, 6580.144581204413, 6447.258565264867, 6482.611043337415, 6492.31830657793, 6494.318096599789, 6495.382938620824, 6612.537122401386, 6616.272210056986, 6629.337066293332, 6632.469402447696, 6632.767853125118, 6282.811515654537, 6417.422431981144, 6438.903416448663, 6442.967785161044, 6471.7734879279], "unit": "ms", "name": "prototype.html", "value": 4916.978868160706}, {"lowerIsBetter": false, "replicates": [849.9107593702661, 891.6121487153093, 927.8979312275646, 955.9187469065129, 963.6723514005237, 14217.64455888602, 14474.131552106881, 14557.417703291856, 14562.0, 14575.344109515085, 12484.750304993895, 12766.744665106693, 12773.425195866184, 12775.552855650054, 12787.552435664753, 749.232037161908, 760.4752720622753, 892.2237653241656, 894.8165626046645, 922.3635691372965, 894.2354287084546, 915.3226612306878, 920.9217216536603, 924.2282693950559, 925.8842644669417, 940.2759874896326, 953.2421724728857, 956.8660387545749, 962.4658314635375, 964.3394274921701, 775.7633921653893, 789.3487872505177, 923.7598224461622, 953.7997020625677, 956.5743244256308, 698.5145323999823, 705.9505834591529, 710.3145464626608, 711.654847399011, 711.8505113926082, 13499.25754083525, 13544.119632223972, 13612.523561675393, 13625.659358516117, 13783.379747911367, 12628.810567841398, 13481.393337299845, 13510.189388636712, 13620.591382258548, 13714.725705485935, 11188.720281992933, 11300.604478843283, 11368.431578421129, 11451.370174640391, 11558.653240402802, 3633.6184700606586, 3696.2977034363653, 3698.8705395311035, 3705.981470092659, 3709.462127991453, 52324.47675523234, 52530.474695253324, 53059.73470132663, 53438.732806336106, 53738.0, 10023.949880250551, 10147.644832430977, 10192.337498062601, 10754.085902698202, 10915.235933484739, 19694.507637308896, 19695.113719882353, 19702.113404896812, 19714.40856774299, 19743.0, 7475.327220550176, 7631.275028872248, 7675.884861727079, 7795.532268063821, 8050.355971522265, 4466.173757854743, 4501.099780043939, 4518.661100417482, 4569.063342014879, 4630.0, 3191.2979144588153, 3214.5499630051813, 3215.710586047267, 3217.8391080445886, 3222.4199644063824, 564.7402194990268, 577.9739911703983, 579.5884921705637, 584.3163498706524, 601.2334273800851, 580.2563297291612, 642.5084810120262, 652.1598438799057, 691.6852831961546, 711.6655172069119, 9053.954730226438, 9133.49765762876, 9294.581743821544, 9427.19868811145, 9533.809323813624, 661.2329697550817, 689.5655736885831, 704.2675617357993, 709.3403135084318, 727.7962170592243, 4466.486354069259, 4641.234196357564, 4681.157391669532, 4840.443349014909, 4870.09903167915, 54091.45908540943, 54311.18533222005, 54523.18215226775, 54542.72728636331, 61360.0, 55289.0, 55708.0, 55743.44256557382, 55835.441645583836, 56205.71897140488, 50751.23873141832, 50906.0, 50999.235011474855, 51302.230466543035, 51371.48628513667, 9489.66786162481, 9693.563789629625, 9771.706848794547, 9924.206063515046, 9939.950300248742, 36417.45373819342, 36688.81655591705, 37244.44133337948, 37362.8131859339, 38219.2356152881, 42455.575444245165, 45304.320435192836, 45988.77005614951, 46607.53392466032, 46824.063518730116, 11567.710807229887, 11940.283582985048, 12389.442475088823, 12596.307203103917, 12614.432350544432, 12679.112462127563, 12893.548725794552, 12996.220226786423, 13091.0, 13182.406791694588, 11854.229475084438, 11904.404779761151, 12128.272303661455, 12398.380080995734, 12464.937675311565, 11417.543298267976, 11569.363684997406, 12019.0, 12067.57763478274, 12098.75802483963, 11815.76368472643, 11956.34240116767, 12019.158658893793, 12200.084993625691, 12297.385130743249, 10546.894531054591, 10766.192535560021, 10859.945700271448, 10907.236493445384, 11115.166362522681, 10062.597496100074, 10401.791964160826, 10413.53139108757, 10454.477276136315, 10509.31689440184], "unit": "ms", "name": "yui.html", "value": 6743.2127416863705}], "name": "dromaeo_css", "value": 7247.870329300537}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 104.0, 110.0, 109.0, 111.0, 102.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [145.0, 124.0, 142.0, 159.0, 126.0, 144.0, 149.0, 123.0, 155.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.2}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 160.0, 159.0, 162.0, 159.0, 161.0, 162.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 148.0, 72.0, 72.0, 71.0, 72.0, 151.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 144.0, 92.0, 92.0, 92.0, 141.0, 92.0, 93.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 58.0, 56.0, 57.0, 58.0, 59.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.5}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 77.0, 80.0, 78.0, 80.0, 78.0, 79.0, 79.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 117.0, 111.0, 115.0, 113.0, 115.0, 127.0, 121.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 152.0, 138.0, 150.0, 132.0, 140.0, 147.0, 138.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.8}, {"lowerIsBetter": true, "replicates": [72.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1476.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7570877369569], "unit": "score", "name": "Richards", "value": 210.43522200000004}, {"lowerIsBetter": false, "replicates": [164.6090534979424], "unit": "score", "name": "DeltaBlue", "value": 401.66685000000007}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5153.846153846154], "unit": "score", "name": "Decrypt", "value": 51.647059701492495}, {"lowerIsBetter": false, "replicates": [960.6147934678194], "unit": "score", "name": "RayTrace", "value": 770.3285489999998}, {"lowerIsBetter": false, "replicates": [546.7468562055768], "unit": "score", "name": "Earley", "value": 1218.960827}, {"lowerIsBetter": false, "replicates": [10600.0], "unit": "score", "name": "Boyer", "value": 62.873867924528355}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [520.5622071837585], "unit": "score", "name": "Splay", "value": 156.54421100000005}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23257.96125551054}]} 14:27:58 INFO - RETURN: dromaeo_css: 7247.87 14:27:58 INFO - RETURN: kraken: 1476.00 14:27:58 INFO - RETURN: v8_7: 23257.96 14:27:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23257.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1476.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7247.87"}}} 14:27:58 INFO - Return code: 0 14:27:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:27:58 INFO - # TBPL SUCCESS # 14:27:58 INFO - Running post-action listener: _resource_record_post_action 14:27:58 INFO - Running post-run listener: _resource_record_post_run 14:27:59 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 323584; Write bytes: 520454144; Read time: 68; Write time: 493092 14:27:59 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 256643072; Read time: 0; Write time: 287044 14:27:59 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 323584; Write bytes: 263811072; Read time: 68; Write time: 206048 14:27:59 INFO - Running post-run listener: _upload_blobber_files 14:27:59 INFO - Blob upload gear active. 14:27:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:27:59 INFO - Copying logs to upload dir... 14:27:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.157554 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-02-11 14:27:59.878837) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:27:59.882635) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009898 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455219334/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-11 14:27:59.937697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:27:59.938001) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1455228388.124913-1507278763 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 14:27:59.989935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:27:59.990684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 14:27:59.991346) ========= ========= Total master_lag: 0.28 =========