builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1454091236.0 results: success (0) buildid: 20160129074726 builduid: 4c046f49a3a04353a857c6c1b32193a3 revision: 3ac0ae17ca78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:55.998281) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:55.998687) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:55.998986) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006235 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.031875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.032158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.051672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.052037) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.37 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.428144) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.428439) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.428779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.429203) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-29 10:13:56-- 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% 84.1M=0s 2016-01-29 10:13:56 (84.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.606513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.606797) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014879 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.661767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:56.662093) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3ac0ae17ca78 --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 3ac0ae17ca78 --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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-29 10:13:57,015 Setting DEBUG logging. 2016-01-29 10:13:57,015 attempt 1/10 2016-01-29 10:13:57,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3ac0ae17ca78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 10:13:57,269 unpacking tar archive at: mozilla-beta-3ac0ae17ca78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:57.213431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:57.213779) ========= echo 3ac0ae17ca78 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3ac0ae17ca78'] 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3ac0ae17ca78 program finished with exit code 0 elapsedTime=0.004060 script_repo_revision: '3ac0ae17ca78' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:57.262269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:57.262568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 10:13:57.272647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-29 10:13:57.272931) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:57 INFO - MultiFileLogger online at 20160129 10:13:57 in /builds/slave/test-pgo 10:13:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:13:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:13:57 INFO - {'append_to_log': False, 10:13:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:13:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:13:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:13:57 INFO - 'branch': 'Mozilla-Beta', 10:13:57 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:57 INFO - 'config_files': ('talos/linux_config.py',), 10:13:57 INFO - 'default_actions': ('clobber', 10:13:57 INFO - 'read-buildbot-config', 10:13:57 INFO - 'download-and-extract', 10:13:57 INFO - 'populate-webroot', 10:13:57 INFO - 'create-virtualenv', 10:13:57 INFO - 'install', 10:13:57 INFO - 'run-tests'), 10:13:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:57 INFO - 'download_minidump_stackwalk': True, 10:13:57 INFO - 'download_symbols': 'ondemand', 10:13:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:57 INFO - 'installer_path': 'installer.exe', 10:13:57 INFO - 'log_level': 'info', 10:13:57 INFO - 'log_name': 'talos', 10:13:57 INFO - 'log_to_console': True, 10:13:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:57 INFO - 'opt_config_files': (), 10:13:57 INFO - 'pip_index': False, 10:13:57 INFO - 'sps_profile': False, 10:13:57 INFO - 'sps_profile_interval': 0, 10:13:57 INFO - 'suite': 'dromaeojs', 10:13:57 INFO - 'system_bits': '32', 10:13:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:57 INFO - 'title': 'talos-linux64-ix-022', 10:13:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:57 INFO - 'use_talos_json': True, 10:13:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:13:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:57 INFO - 'work_dir': 'build'} 10:13:57 INFO - ##### 10:13:57 INFO - ##### Running clobber step. 10:13:57 INFO - ##### 10:13:57 INFO - Running pre-action listener: _resource_record_pre_action 10:13:57 INFO - Running main action method: clobber 10:13:57 INFO - rmtree: /builds/slave/test-pgo/build 10:13:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:13:58 INFO - Running post-action listener: _resource_record_post_action 10:13:58 INFO - ##### 10:13:58 INFO - ##### Running read-buildbot-config step. 10:13:58 INFO - ##### 10:13:58 INFO - Running pre-action listener: _resource_record_pre_action 10:13:58 INFO - Running main action method: read_buildbot_config 10:13:58 INFO - Using buildbot properties: 10:13:58 INFO - { 10:13:58 INFO - "properties": { 10:13:58 INFO - "buildnumber": 93, 10:13:58 INFO - "product": "firefox", 10:13:58 INFO - "script_repo_revision": "production", 10:13:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:13:58 INFO - "repository": "", 10:13:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:13:58 INFO - "buildid": "20160129074726", 10:13:58 INFO - "slavename": "talos-linux64-ix-022", 10:13:58 INFO - "pgo_build": "True", 10:13:58 INFO - "basedir": "/builds/slave/test-pgo", 10:13:58 INFO - "project": "", 10:13:58 INFO - "platform": "ubuntu64_hw", 10:13:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:13:58 INFO - "slavebuilddir": "test", 10:13:58 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:13:58 INFO - "branch": "mozilla-beta", 10:13:58 INFO - "repo_path": "releases/mozilla-beta", 10:13:58 INFO - "stage_platform": "linux64-pgo", 10:13:58 INFO - "builduid": "4c046f49a3a04353a857c6c1b32193a3", 10:13:58 INFO - "revision": "3ac0ae17ca78" 10:13:58 INFO - }, 10:13:58 INFO - "sourcestamp": { 10:13:58 INFO - "repository": "", 10:13:58 INFO - "hasPatch": false, 10:13:58 INFO - "project": "", 10:13:58 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:13:58 INFO - "changes": [ 10:13:58 INFO - { 10:13:58 INFO - "category": null, 10:13:58 INFO - "files": [ 10:13:58 INFO - { 10:13:58 INFO - "url": null, 10:13:58 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:13:58 INFO - } 10:13:58 INFO - ], 10:13:58 INFO - "repository": "", 10:13:58 INFO - "rev": "3ac0ae17ca78", 10:13:58 INFO - "who": "sendchange", 10:13:58 INFO - "when": 1454091181, 10:13:58 INFO - "number": 7535439, 10:13:58 INFO - "comments": "Bug 1242890 - Fix UpdateTestcase for unknown _download()_ method. r=maja_zf, a=test-only", 10:13:58 INFO - "project": "", 10:13:58 INFO - "at": "Fri 29 Jan 2016 10:13:01", 10:13:58 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:13:58 INFO - "revlink": "", 10:13:58 INFO - "properties": [ 10:13:58 INFO - [ 10:13:58 INFO - "buildid", 10:13:58 INFO - "20160129074726", 10:13:58 INFO - "Change" 10:13:58 INFO - ], 10:13:58 INFO - [ 10:13:58 INFO - "builduid", 10:13:58 INFO - "4c046f49a3a04353a857c6c1b32193a3", 10:13:58 INFO - "Change" 10:13:58 INFO - ], 10:13:58 INFO - [ 10:13:58 INFO - "pgo_build", 10:13:58 INFO - "True", 10:13:58 INFO - "Change" 10:13:58 INFO - ] 10:13:58 INFO - ], 10:13:58 INFO - "revision": "3ac0ae17ca78" 10:13:58 INFO - } 10:13:58 INFO - ], 10:13:58 INFO - "revision": "3ac0ae17ca78" 10:13:58 INFO - } 10:13:58 INFO - } 10:13:58 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:13:58 INFO - Running post-action listener: _resource_record_post_action 10:13:58 INFO - ##### 10:13:58 INFO - ##### Running download-and-extract step. 10:13:58 INFO - ##### 10:13:58 INFO - Running pre-action listener: _resource_record_pre_action 10:13:58 INFO - Running main action method: download_and_extract 10:13:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/test_packages.json 10:13:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:13:58 INFO - Downloaded 1270 bytes. 10:13:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:13:58 INFO - Using the following test package requirements: 10:13:58 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:13:58 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:13:58 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'jsshell-linux-x86_64.zip'], 10:13:58 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:13:58 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:13:58 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:13:58 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:13:58 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:13:58 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:13:58 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:13:58 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:13:58 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:58 INFO - Downloaded 21581983 bytes. 10:13:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:13:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:13:59 INFO - Return code: 0 10:13:59 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:13:59 INFO - Downloaded 21581983 bytes. 10:13:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:13:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:13:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:14:01 INFO - Return code: 0 10:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:03 INFO - Downloaded 11132038 bytes. 10:14:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:14:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:14:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:14:04 INFO - Return code: 0 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:04 INFO - Downloaded 57949679 bytes. 10:14:04 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:04 INFO - mkdir: /builds/slave/test-pgo/properties 10:14:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:14:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:14:04 INFO - Contents: 10:14:04 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:14:04 INFO - Running post-action listener: _resource_record_post_action 10:14:04 INFO - Running post-action listener: set_extra_try_arguments 10:14:04 INFO - ##### 10:14:04 INFO - ##### Running populate-webroot step. 10:14:04 INFO - ##### 10:14:04 INFO - Running pre-action listener: _resource_record_pre_action 10:14:04 INFO - Running main action method: populate_webroot 10:14:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:04 INFO - '--tppagecycles', 10:14:04 INFO - '7'], 10:14:04 INFO - 'tests': ['tsvgm']}}, 10:14:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:14:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:14:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:14:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'tests': ['damp', 'tps']}, 10:14:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['damp', 'tps']}, 10:14:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:14:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:04 INFO - 'other': {'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'other_l64': {'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'other_nol64': {'tests': ['a11yr', 10:14:04 INFO - 'ts_paint', 10:14:04 INFO - 'tpaint', 10:14:04 INFO - 'sessionrestore', 10:14:04 INFO - 'sessionrestore_no_auto_restore']}, 10:14:04 INFO - 'svgr': {'tests': ['tsvgx', 10:14:04 INFO - 'tsvgr_opacity', 10:14:04 INFO - 'tart', 10:14:04 INFO - 'tscrollx', 10:14:04 INFO - 'cart']}, 10:14:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['tsvgx', 10:14:04 INFO - 'tsvgr_opacity', 10:14:04 INFO - 'tart', 10:14:04 INFO - 'tscrollx', 10:14:04 INFO - 'cart']}, 10:14:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'tests': ['tp5o']}, 10:14:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'talos_options': ['--e10s'], 10:14:04 INFO - 'tests': ['tp5o']}, 10:14:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'talos_options': ['--xperf_path', 10:14:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:04 INFO - 'tests': ['tp5n']}, 10:14:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:04 INFO - 'talos_options': ['--e10s', 10:14:04 INFO - '--xperf_path', 10:14:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:04 INFO - 'tests': ['tp5n']}}, 10:14:04 INFO - 'talos.zip': {'path': '', 10:14:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:04 INFO - Running post-action listener: _resource_record_post_action 10:14:04 INFO - ##### 10:14:04 INFO - ##### Running create-virtualenv step. 10:14:04 INFO - ##### 10:14:04 INFO - Running pre-action listener: _resource_record_pre_action 10:14:04 INFO - Running main action method: create_virtualenv 10:14:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:14:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:14:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:14:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:05 INFO - Using real prefix '/usr' 10:14:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:14:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:07 INFO - Installing pip.................done. 10:14:07 INFO - Return code: 0 10:14:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:14:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:14:07 INFO - Using env: {'DISPLAY': ':0', 10:14:07 INFO - 'HOME': '/home/cltbld', 10:14:07 INFO - 'LANG': 'en_US.UTF-8', 10:14:07 INFO - 'LANGUAGE': 'en_US:en', 10:14:07 INFO - 'LOGNAME': 'cltbld', 10:14:07 INFO - 'MAIL': '/var/mail/cltbld', 10:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:07 INFO - 'MOZ_NO_REMOTE': '1', 10:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:07 INFO - 'NO_EM_RESTART': '1', 10:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:07 INFO - 'SHELL': '/bin/bash', 10:14:07 INFO - 'SHLVL': '1', 10:14:07 INFO - 'TERM': 'linux', 10:14:07 INFO - 'TMOUT': '86400', 10:14:07 INFO - 'USER': 'cltbld', 10:14:07 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:07 INFO - '_': '/tools/buildbot/bin/python'} 10:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:14:07 INFO - Cleaning up... 10:14:07 INFO - Return code: 0 10:14:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:07 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:14:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:14:07 INFO - Using env: {'DISPLAY': ':0', 10:14:07 INFO - 'HOME': '/home/cltbld', 10:14:07 INFO - 'LANG': 'en_US.UTF-8', 10:14:07 INFO - 'LANGUAGE': 'en_US:en', 10:14:07 INFO - 'LOGNAME': 'cltbld', 10:14:07 INFO - 'MAIL': '/var/mail/cltbld', 10:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:07 INFO - 'MOZ_NO_REMOTE': '1', 10:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:07 INFO - 'NO_EM_RESTART': '1', 10:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:07 INFO - 'SHELL': '/bin/bash', 10:14:07 INFO - 'SHLVL': '1', 10:14:07 INFO - 'TERM': 'linux', 10:14:07 INFO - 'TMOUT': '86400', 10:14:07 INFO - 'USER': 'cltbld', 10:14:07 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:07 INFO - '_': '/tools/buildbot/bin/python'} 10:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:07 INFO - Downloading/unpacking psutil>=0.7.1 10:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:09 INFO - Installing collected packages: psutil 10:14:09 INFO - Running setup.py install for psutil 10:14:09 INFO - building 'psutil._psutil_linux' extension 10:14:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:14:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:14:10 INFO - building 'psutil._psutil_posix' extension 10:14:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:14:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:14:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:10 INFO - Successfully installed psutil 10:14:10 INFO - Cleaning up... 10:14:10 INFO - Return code: 0 10:14:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:14: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')]} 10:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:10 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:14:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:14:10 INFO - Using env: {'DISPLAY': ':0', 10:14:10 INFO - 'HOME': '/home/cltbld', 10:14:10 INFO - 'LANG': 'en_US.UTF-8', 10:14:10 INFO - 'LANGUAGE': 'en_US:en', 10:14:10 INFO - 'LOGNAME': 'cltbld', 10:14:10 INFO - 'MAIL': '/var/mail/cltbld', 10:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:10 INFO - 'MOZ_NO_REMOTE': '1', 10:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:10 INFO - 'NO_EM_RESTART': '1', 10:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:10 INFO - 'SHELL': '/bin/bash', 10:14:10 INFO - 'SHLVL': '1', 10:14:10 INFO - 'TERM': 'linux', 10:14:10 INFO - 'TMOUT': '86400', 10:14:10 INFO - 'USER': 'cltbld', 10:14:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:10 INFO - '_': '/tools/buildbot/bin/python'} 10:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:14:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:14:12 INFO - Installing collected packages: mozsystemmonitor 10:14:12 INFO - Running setup.py install for mozsystemmonitor 10:14:12 INFO - Successfully installed mozsystemmonitor 10:14:12 INFO - Cleaning up... 10:14:12 INFO - Return code: 0 10:14:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:12 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:14:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:14:12 INFO - Using env: {'DISPLAY': ':0', 10:14:12 INFO - 'HOME': '/home/cltbld', 10:14:12 INFO - 'LANG': 'en_US.UTF-8', 10:14:12 INFO - 'LANGUAGE': 'en_US:en', 10:14:12 INFO - 'LOGNAME': 'cltbld', 10:14:12 INFO - 'MAIL': '/var/mail/cltbld', 10:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:12 INFO - 'MOZ_NO_REMOTE': '1', 10:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:12 INFO - 'NO_EM_RESTART': '1', 10:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:12 INFO - 'SHELL': '/bin/bash', 10:14:12 INFO - 'SHLVL': '1', 10:14:12 INFO - 'TERM': 'linux', 10:14:12 INFO - 'TMOUT': '86400', 10:14:12 INFO - 'USER': 'cltbld', 10:14:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:12 INFO - '_': '/tools/buildbot/bin/python'} 10:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:14 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:14:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:15 INFO - Downloading docopt-0.6.1.tar.gz 10:14:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:15 INFO - Running setup.py install for blobuploader 10:14:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:14:15 INFO - Running setup.py install for requests 10:14:15 INFO - Running setup.py install for docopt 10:14:15 INFO - Successfully installed blobuploader requests docopt 10:14:15 INFO - Cleaning up... 10:14:15 INFO - Return code: 0 10:14:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:15 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:14:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:15 INFO - Using env: {'DISPLAY': ':0', 10:14:15 INFO - 'HOME': '/home/cltbld', 10:14:15 INFO - 'LANG': 'en_US.UTF-8', 10:14:15 INFO - 'LANGUAGE': 'en_US:en', 10:14:15 INFO - 'LOGNAME': 'cltbld', 10:14:15 INFO - 'MAIL': '/var/mail/cltbld', 10:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:15 INFO - 'MOZ_NO_REMOTE': '1', 10:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:15 INFO - 'NO_EM_RESTART': '1', 10:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:15 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:15 INFO - 'SHELL': '/bin/bash', 10:14:15 INFO - 'SHLVL': '1', 10:14:15 INFO - 'TERM': 'linux', 10:14:15 INFO - 'TMOUT': '86400', 10:14:15 INFO - 'USER': 'cltbld', 10:14:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:15 INFO - '_': '/tools/buildbot/bin/python'} 10:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:16 INFO - Running setup.py (path:/tmp/pip-7xv4bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:16 INFO - Running setup.py (path:/tmp/pip-Xkxxt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:16 INFO - Running setup.py (path:/tmp/pip-bHmXEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:16 INFO - Running setup.py (path:/tmp/pip-hN_0GB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:16 INFO - Running setup.py (path:/tmp/pip-Y8mFpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:16 INFO - Running setup.py (path:/tmp/pip-nu_05Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:16 INFO - Running setup.py (path:/tmp/pip-5ELtKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:16 INFO - Running setup.py (path:/tmp/pip-VcijCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:16 INFO - Running setup.py (path:/tmp/pip-JMg6IZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:16 INFO - Running setup.py (path:/tmp/pip-rg5Y8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:16 INFO - Running setup.py (path:/tmp/pip-fDmEWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:16 INFO - Running setup.py (path:/tmp/pip-xRwOgp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:16 INFO - Running setup.py (path:/tmp/pip-VTeVFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:17 INFO - Running setup.py (path:/tmp/pip-8vk8Eg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:17 INFO - Running setup.py (path:/tmp/pip-7aiOMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:17 INFO - Running setup.py (path:/tmp/pip-GbHeRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:17 INFO - Running setup.py (path:/tmp/pip-d4MyWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:17 INFO - Running setup.py install for manifestparser 10:14:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:14:17 INFO - Running setup.py install for mozcrash 10:14:17 INFO - Running setup.py install for mozdebug 10:14:17 INFO - Running setup.py install for mozdevice 10:14:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:14:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:14:17 INFO - Running setup.py install for mozfile 10:14:17 INFO - Running setup.py install for mozhttpd 10:14:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:14:17 INFO - Running setup.py install for mozinfo 10:14:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for mozInstall 10:14:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for mozleak 10:14:18 INFO - Running setup.py install for mozlog 10:14:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for moznetwork 10:14:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for mozprocess 10:14:18 INFO - Running setup.py install for mozprofile 10:14:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for mozrunner 10:14:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:14:18 INFO - Running setup.py install for mozscreenshot 10:14:18 INFO - Running setup.py install for moztest 10:14:19 INFO - Running setup.py install for mozversion 10:14:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:14:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:19 INFO - Cleaning up... 10:14:19 INFO - Return code: 0 10:14:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:14: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')]} 10:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:19 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:14:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:19 INFO - Using env: {'DISPLAY': ':0', 10:14:19 INFO - 'HOME': '/home/cltbld', 10:14:19 INFO - 'LANG': 'en_US.UTF-8', 10:14:19 INFO - 'LANGUAGE': 'en_US:en', 10:14:19 INFO - 'LOGNAME': 'cltbld', 10:14:19 INFO - 'MAIL': '/var/mail/cltbld', 10:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:19 INFO - 'MOZ_NO_REMOTE': '1', 10:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:19 INFO - 'NO_EM_RESTART': '1', 10:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:19 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:19 INFO - 'SHELL': '/bin/bash', 10:14:19 INFO - 'SHLVL': '1', 10:14:19 INFO - 'TERM': 'linux', 10:14:19 INFO - 'TMOUT': '86400', 10:14:19 INFO - 'USER': 'cltbld', 10:14:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:19 INFO - '_': '/tools/buildbot/bin/python'} 10:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:19 INFO - Running setup.py (path:/tmp/pip-Aqq448-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:19 INFO - Running setup.py (path:/tmp/pip-Vtsash-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:19 INFO - Running setup.py (path:/tmp/pip-ylNXwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:19 INFO - Running setup.py (path:/tmp/pip-mnC7fY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:19 INFO - Running setup.py (path:/tmp/pip-zopquE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:19 INFO - Running setup.py (path:/tmp/pip-MQY6t5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:19 INFO - Running setup.py (path:/tmp/pip-yXD_Qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:19 INFO - Running setup.py (path:/tmp/pip-OM0vtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:19 INFO - Running setup.py (path:/tmp/pip-_tjI0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:14:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:19 INFO - Running setup.py (path:/tmp/pip-JLUvPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:20 INFO - Running setup.py (path:/tmp/pip-mYhOxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:20 INFO - Running setup.py (path:/tmp/pip-vtMJBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:20 INFO - Running setup.py (path:/tmp/pip-rfutGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:20 INFO - Running setup.py (path:/tmp/pip-pni5ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:20 INFO - Running setup.py (path:/tmp/pip-D_WVbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:20 INFO - Running setup.py (path:/tmp/pip-oT6GJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:14:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:20 INFO - Running setup.py (path:/tmp/pip-8Wtbp1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:14:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:22 INFO - Downloading blessings-1.6.tar.gz 10:14:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:22 INFO - Installing collected packages: blessings 10:14:22 INFO - Running setup.py install for blessings 10:14:22 INFO - Successfully installed blessings 10:14:22 INFO - Cleaning up... 10:14:22 INFO - Return code: 0 10:14:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:14:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:14:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:14:22 INFO - Reading from file tmpfile_stdout 10:14:22 INFO - Current package versions: 10:14:22 INFO - argparse == 1.2.1 10:14:22 INFO - blessings == 1.6 10:14:22 INFO - blobuploader == 1.2.4 10:14:22 INFO - docopt == 0.6.1 10:14:22 INFO - manifestparser == 1.1 10:14:22 INFO - mozInstall == 1.12 10:14:22 INFO - mozcrash == 0.16 10:14:22 INFO - mozdebug == 0.1 10:14:22 INFO - mozdevice == 0.47 10:14:22 INFO - mozfile == 1.2 10:14:22 INFO - mozhttpd == 0.7 10:14:22 INFO - mozinfo == 0.9 10:14:22 INFO - mozleak == 0.1 10:14:22 INFO - mozlog == 3.1 10:14:22 INFO - moznetwork == 0.27 10:14:22 INFO - mozprocess == 0.22 10:14:22 INFO - mozprofile == 0.27 10:14:22 INFO - mozrunner == 6.11 10:14:22 INFO - mozscreenshot == 0.1 10:14:22 INFO - mozsystemmonitor == 0.0 10:14:22 INFO - moztest == 0.7 10:14:22 INFO - mozversion == 1.4 10:14:22 INFO - psutil == 3.1.1 10:14:22 INFO - requests == 1.2.3 10:14:22 INFO - wsgiref == 0.1.2 10:14:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:14: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')]} 10:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:22 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:14:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:14:22 INFO - Using env: {'DISPLAY': ':0', 10:14:22 INFO - 'HOME': '/home/cltbld', 10:14:22 INFO - 'LANG': 'en_US.UTF-8', 10:14:22 INFO - 'LANGUAGE': 'en_US:en', 10:14:22 INFO - 'LOGNAME': 'cltbld', 10:14:22 INFO - 'MAIL': '/var/mail/cltbld', 10:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:22 INFO - 'MOZ_NO_REMOTE': '1', 10:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:22 INFO - 'NO_EM_RESTART': '1', 10:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:22 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:22 INFO - 'SHELL': '/bin/bash', 10:14:22 INFO - 'SHLVL': '1', 10:14:22 INFO - 'TERM': 'linux', 10:14:22 INFO - 'TMOUT': '86400', 10:14:22 INFO - 'USER': 'cltbld', 10:14:22 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:22 INFO - '_': '/tools/buildbot/bin/python'} 10:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:14:22 INFO - Cleaning up... 10:14:23 INFO - Return code: 0 10:14:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:23 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:14:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:14:23 INFO - Using env: {'DISPLAY': ':0', 10:14:23 INFO - 'HOME': '/home/cltbld', 10:14:23 INFO - 'LANG': 'en_US.UTF-8', 10:14:23 INFO - 'LANGUAGE': 'en_US:en', 10:14:23 INFO - 'LOGNAME': 'cltbld', 10:14:23 INFO - 'MAIL': '/var/mail/cltbld', 10:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:23 INFO - 'MOZ_NO_REMOTE': '1', 10:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:23 INFO - 'NO_EM_RESTART': '1', 10:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:23 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:23 INFO - 'SHELL': '/bin/bash', 10:14:23 INFO - 'SHLVL': '1', 10:14:23 INFO - 'TERM': 'linux', 10:14:23 INFO - 'TMOUT': '86400', 10:14:23 INFO - 'USER': 'cltbld', 10:14:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:23 INFO - '_': '/tools/buildbot/bin/python'} 10:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:23 INFO - Downloading/unpacking jsonschema 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:24 INFO - Downloading/unpacking functools32 (from jsonschema) 10:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:25 INFO - warning: no files found matching '*.txt' 10:14:25 INFO - no previously-included directories found matching 'build' 10:14:25 INFO - no previously-included directories found matching 'dist' 10:14:25 INFO - no previously-included directories found matching '.git*' 10:14:25 INFO - Installing collected packages: jsonschema, functools32 10:14:25 INFO - Running setup.py install for functools32 10:14:25 INFO - warning: no files found matching '*.txt' 10:14:25 INFO - no previously-included directories found matching 'build' 10:14:25 INFO - no previously-included directories found matching 'dist' 10:14:25 INFO - no previously-included directories found matching '.git*' 10:14:25 INFO - Successfully installed jsonschema functools32 10:14:25 INFO - Cleaning up... 10:14:25 INFO - Return code: 0 10:14:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:14: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')]} 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:25 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 0x7f11b0c3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f9d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:14:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:14:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:14:25 INFO - Using env: {'DISPLAY': ':0', 10:14:25 INFO - 'HOME': '/home/cltbld', 10:14:25 INFO - 'LANG': 'en_US.UTF-8', 10:14:25 INFO - 'LANGUAGE': 'en_US:en', 10:14:25 INFO - 'LOGNAME': 'cltbld', 10:14:25 INFO - 'MAIL': '/var/mail/cltbld', 10:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:25 INFO - 'MOZ_NO_REMOTE': '1', 10:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:25 INFO - 'NO_EM_RESTART': '1', 10:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:25 INFO - 'SHELL': '/bin/bash', 10:14:25 INFO - 'SHLVL': '1', 10:14:25 INFO - 'TERM': 'linux', 10:14:25 INFO - 'TMOUT': '86400', 10:14:25 INFO - 'USER': 'cltbld', 10:14:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:25 INFO - '_': '/tools/buildbot/bin/python'} 10:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:25 INFO - Downloading/unpacking flake8 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:28 INFO - no previously-included directories found matching 'docs/_build' 10:14:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:28 INFO - Running setup.py install for pep8 10:14:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:28 INFO - no previously-included directories found matching 'docs/_build' 10:14:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:14:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:28 INFO - Cleaning up... 10:14:28 INFO - Return code: 0 10:14:28 INFO - Running post-action listener: _resource_record_post_action 10:14:28 INFO - Running post-action listener: _start_resource_monitoring 10:14:28 INFO - Starting resource monitoring. 10:14:28 INFO - ##### 10:14:28 INFO - ##### Running install step. 10:14:28 INFO - ##### 10:14:28 INFO - Running pre-action listener: _resource_record_pre_action 10:14:28 INFO - Running main action method: install 10:14:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:14:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:14:28 INFO - Reading from file tmpfile_stdout 10:14:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:14:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:14:28 INFO - Reading from file tmpfile_stdout 10:14:28 INFO - Output received: 10:14:28 INFO - Usage: mozinstall [options] installer 10:14:28 INFO - Options: 10:14:28 INFO - -h, --help show this help message and exit 10:14:28 INFO - -d DEST, --destination=DEST 10:14:28 INFO - Directory to install application into. [default: 10:14:28 INFO - "/builds/slave/test-pgo"] 10:14:28 INFO - --app=APP Application being installed. [default: firefox] 10:14:28 INFO - mkdir: /builds/slave/test-pgo/build/application 10:14:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:14:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:14:43 INFO - Reading from file tmpfile_stdout 10:14:43 INFO - Output received: 10:14:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:14:43 INFO - Running post-action listener: _resource_record_post_action 10:14:43 INFO - ##### 10:14:43 INFO - ##### Running run-tests step. 10:14:43 INFO - ##### 10:14:43 INFO - Running pre-action listener: _resource_record_pre_action 10:14:43 INFO - Running main action method: run_tests 10:14:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:14:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:14:43 INFO - Python 2.7.3 10:14:43 INFO - Return code: 0 10:14:43 INFO - grabbing minidump binary from tooltool 10:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:43 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 0x202c350>, '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 0x202d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:14:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:14:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:14:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:43 INFO - Return code: 0 10:14:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:14:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:14:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:14:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:14:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:14:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:14:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:14:44 INFO - Return code: 0 10:14:44 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/1454082446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:14:44 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/1454082446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 10:14:44 INFO - Using env: {'DISPLAY': ':0', 10:14:44 INFO - 'HOME': '/home/cltbld', 10:14:44 INFO - 'LANG': 'en_US.UTF-8', 10:14:44 INFO - 'LANGUAGE': 'en_US:en', 10:14:44 INFO - 'LOGNAME': 'cltbld', 10:14:44 INFO - 'MAIL': '/var/mail/cltbld', 10:14:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:14:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:44 INFO - 'MOZ_NO_REMOTE': '1', 10:14:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:44 INFO - 'NO_EM_RESTART': '1', 10:14:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:14:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:14:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:14:44 INFO - 'SHELL': '/bin/bash', 10:14:44 INFO - 'SHLVL': '1', 10:14:44 INFO - 'TERM': 'linux', 10:14:44 INFO - 'TMOUT': '86400', 10:14:44 INFO - 'USER': 'cltbld', 10:14:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103', 10:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:44 INFO - '_': '/tools/buildbot/bin/python'} 10:14:44 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/1454082446/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 10:14:44 INFO - mozversion INFO | application_buildid: 20160129074726 10:14:44 INFO - mozversion INFO | application_changeset: 3ac0ae17ca787cc6bb7711091cbf5d1d03bca225 10:14:44 INFO - mozversion INFO | application_display_name: Nightly 10:14:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:44 INFO - mozversion INFO | application_name: Firefox 10:14:44 INFO - mozversion INFO | application_remotingname: firefox 10:14:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:14:44 INFO - mozversion INFO | application_vendor: Mozilla 10:14:44 INFO - mozversion INFO | application_version: 45.0 10:14:44 INFO - mozversion INFO | platform_buildid: 20160129074726 10:14:44 INFO - mozversion INFO | platform_changeset: 3ac0ae17ca787cc6bb7711091cbf5d1d03bca225 10:14:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:14:44 INFO - mozversion INFO | platform_version: 45.0 10:14:44 INFO - 2016-01-29 10:14:44,523 DEBUG : using testdate: 1454091284 10:14:44 INFO - 2016-01-29 10:14:44,523 DEBUG : actual date: 1454091284 10:14:44 INFO - 2016-01-29 10:14:44,570 INFO : starting webserver on 'localhost:44659' 10:14:44 INFO - 2016-01-29 10:14:44,571 INFO : Starting test suite talos-linux64-ix-022 10:14:44 INFO - 2016-01-29 10:14:44,571 INFO : Starting test dromaeo_css 10:14:44 INFO - 2016-01-29 10:14:44,571 DEBUG : operating with platform_type : linux_ 10:14:44 INFO - 2016-01-29 10:14:44,572 INFO : Initialising browser for dromaeo_css test... 10:14:44 INFO - 2016-01-29 10:14:44,586 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQYEE8f/profile http://localhost:44659/getInfo.html 10:14:48 INFO - 2016-01-29 10:14:48,833 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:14:48 INFO - 2016-01-29 10:14:48,834 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:14:48 INFO - 2016-01-29 10:14:48,834 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:14:48 INFO - 2016-01-29 10:14:48,834 DEBUG : BROWSER_OUTPUT: __metrics 10:14:48 INFO - 2016-01-29 10:14:48,997 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:49 INFO - 2016-01-29 10:14:49,755 INFO : Browser initialized. 10:14:49 INFO - 2016-01-29 10:14:49,756 INFO : Running cycle 1/1 for dromaeo_css test... 10:14:49 INFO - 2016-01-29 10:14:49,756 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQYEE8f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:15:01 INFO - 2016-01-29 10:15:01,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 133804032 10:15:01 INFO - 2016-01-29 10:15:01,544 DEBUG : BROWSER_OUTPUT: 10:15:52 INFO - 2016-01-29 10:15:52,449 DEBUG : BROWSER_OUTPUT: 1454091352448 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:18:00 INFO - 2016-01-29 10:18:00,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44659/tests/dromaeo/cssquery-ext.html) 10:18:01 INFO - 2016-01-29 10:18:01,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 238141440 10:18:01 INFO - 2016-01-29 10:18:01,919 DEBUG : BROWSER_OUTPUT: 10:21:03 INFO - 2016-01-29 10:21:03,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-ext.html (next: http://localhost:44659/tests/dromaeo/cssquery-jquery.html) 10:21:04 INFO - 2016-01-29 10:21:04,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 214667264 10:21:04 INFO - 2016-01-29 10:21:04,542 DEBUG : BROWSER_OUTPUT: 10:24:06 INFO - 2016-01-29 10:24:06,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44659/tests/dromaeo/cssquery-mootools.html) 10:24:06 INFO - 2016-01-29 10:24:06,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 208957440 10:24:06 INFO - 2016-01-29 10:24:06,914 DEBUG : BROWSER_OUTPUT: 10:27:08 INFO - 2016-01-29 10:27:08,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44659/tests/dromaeo/cssquery-prototype.html) 10:27:09 INFO - 2016-01-29 10:27:09,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 207396864 10:27:09 INFO - 2016-01-29 10:27:09,193 DEBUG : BROWSER_OUTPUT: 10:30:11 INFO - 2016-01-29 10:30:11,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44659/tests/dromaeo/cssquery-yui.html) 10:30:12 INFO - 2016-01-29 10:30:12,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 199880704 10:30:12 INFO - 2016-01-29 10:30:12,142 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/dromaeo/cssquery-yui.html (next: http://localhost:44659/tests/dromaeo/cssquery-dojo.html) 10:33:14 INFO - 2016-01-29 10:33:14,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 243077120 10:33:14 INFO - 2016-01-29 10:33:14,501 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,502 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:33:14 INFO - 2016-01-29 10:33:14,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:33:14 INFO - 2016-01-29 10:33:14,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:33:14 INFO - 2016-01-29 10:33:14,503 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:33:14 INFO - 2016-01-29 10:33:14,504 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3331.633520312766;3412.0275721419403;3439.105832483555;3445.4659527773188;3467.1332166958255;5666.036773748462;5678.943210567893;5699.6580205187665;5704.515116215116;5705.857353566153;5683.545316374691;5694.088945768678;5707.086866101425;5725.227094342263;5757.827265182041;5046.21783623539;5080.568151707109;5210.2445145453985;5224.895502089956;5283.07546179419;5224.869378265555;5232;5237.947620523803;5241.056609810233;5245.659032162897;5128.307678463397;5141.665791723544;5265.104932161542;5299.125644268691;5300.443453437391;5123.205903085028;5221.686698798084;5222.3472065991755;5225.399079105913;5233.450487698775;5184.7407629618365;5191.766370513336;5211.7133557654315;5268;5302.443243459458;5373.113436283009;5373.704446255454;5467.425920278353;5515.255440515519;5561.666300021971;6069.939300607026;6078;6082.148499210114;6088.786892458787;6123.448889599913;6039.63762174271;6082.148499210114;6106.236720409949;6115.082737589352;6119.388061193889;5590.245316882209;5638.2670252866865;5676.063449530864;5725.51333136688;5729.7708091676695;6200.720967556471;6229.968850155811;6247.437730604267;6253.7185826637915;6258.061290806416;6009.308929473166;6012.278526576752;6015.06766451192;6023.698815059317;6033.78881739137;5841.9415805842245;5952.672603006876;6089.482393996472;6180.8763824723255;6195.690215489208;6019.729112189962;6020.57855950088;6024.689883715691;6026.849328766816;6058.787942421994;5830.883382332415;5939.732712027882;6011.819645410645;6013.939860601426;6023.668698221552;4588.311753237042;4603.424571928509;4615.284630882219;4618.053299073682;4620.168369693488;4099.836006559704;4167.854125105607;4169.207850508394;4177.540470548237;4195.286801243735;5782.88434231313;5785.826425207167;5790.94209057904;5798.275215598051;5811.070228763378;6084.056971169476;6084.543659225487;6090.421409966046;6094.177286066413;6104.4505994460715;5590.664560126405;5683.119116536944;5692.686902220335;5707.71461426927;5849.707514624251;5270.578353731692;5284.762185701576;5308.814191503279;5313.734313284321;5314.7874085036165;6342.809715708536;6360.618362898241;6361.61830290184;6361.777337793155;6362.936370636235;5943.940560594512;6067.393260674074;6082.452579267887;6095.238095238095;6183.288921774054;6401.29585745577;6407.8718425630295;6417.743290268337;6428.774992875227;6431.5819471734185;6103.206583144163;6110.7861224856915;6115.541334399849;6116.694165291807;6119.265688117454;5987;6111.84720381994;6134.8159555213415;6210.968945155245;6211.16149319836;5993.280806303097;6033.497341086497;6047.03247480401;6056.727447264796;6090.634561926298;5980.491658208927;6028.0355143176885;6032.939670603413;6040.516758659384;6042.939570604238;5672.5745569081655;5788.450097240755;5833.300003999547;5927.229460170151;5955.136505206808;5966.76132954677;6017.037274036134;6059.363766804422;6066.878662426815;6074.179985701874;5640.5769567281795;5861.560382971209;5908.291005079418;5917.082852157922;5940.465358117617 10:33:14 INFO - 2016-01-29 10:33:14,507 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.3305915313215;582.1616871704746;604.8336707405463;621.5276389943641;683.4668958212593;32874.67125328746;33595.32809343815;33596;33629.831850840776;40568.188636227256;45866.54133458665;46588.068238635205;46676.766616166955;46722;46773;9023;9201.631934722604;9203.723888283363;9209.263258939269;9211.677591284306;8332;8488.618012189467;11002.33985960845;11261.042811361043;11265.098792096613;10863.076638485738;11008.064314533234;11011.394373309466;11015.339079655207;11015.724606884813;10855.837162442569;10984.835227471594;10985.395803230818;10992.120630349553;10999.890001100006;10756.354618722824;10837.133029357712;10894.727631809188;10898.400587967659;10902.127829773599;42231.366529502084;42728.35907461391;42729.14541709179;42751.35872961908;42755.35866961998;3601.441776524643;3618.1316484043905;3634.436662317345;3822.57951625321;3939.4878665773554;32178.51378011613;32210;32488.837555812304;32813.507797383056;32847.83576082104;4298.591633794785;4301.333293339538;4322.783860806947;4356.912861742748;4375.6280716138845;299777;300861;301301;301386;305193.9999999978;56164;57013.14480282799;57072.14391784126;62820.68589657023;63461.36538634647;71724.64137679279;72946;73430.63284683542;73662.63168684123;73712.26287737161;17489.56276093108;17953;17963.281468741105;17972.730409043874;17982.550436238937;13409.66475838112;13490.595282141552;13555.525556605471;13562.796558051637;13564.525241616497;20092.296769612993;20360;20477.07853146612;20481.79518204799;20505.38483845487;8487.448315859572;8564.785880353042;8594.14058594148;8659.610317535726;8701.608427620773;985.5712764947127;1017.2269075502523;1064.4252103863828;1136.4601814138384;1138.1057039238326;29451;29479;29775.255618609706;30392;30460.54309185364;1142.6115120858947;1176.1472932124314;1187.8099504079478;1194.2535915053093;1229.1764517773113;13575.456981720818;15524.92237538805;15577.766333505006;15734.449294274646;15809.841901581067;329924;336279;337229;337456;337657;56865;56937.715311424006;57017.71491142518;57022.42977570171;57147.428365723645;1354.0927578522414;1405.0375492787473;1440.553428437188;1454.6508837879044;1538.830728619851;25517.23448296554;26047.869760651076;26439.471210576066;27355.179344619693;27905.58141627918;44408;44751.552484476044;44752;44758;44861;224485;224945;225591;225731;227669;34246.828765856015;34629.48055779115;34872;34965.300693986486;35141.824290879405;44340.778296108314;46019.07961840677;46111.76944115258;46142.53857461383;46166.53833461623;38059.809700951315;38348.424773628976;38421;38562.80718596389;39376.2124757509;38300.425493618175;38519.336796639924;38605;39499;39549;37916.24167516579;38026.619733802305;38305;38613.613863861;38759.6124038756;29547;30649.693503064686;30955.69044309528;30986.845065774527;31019.68980310168;24424.75575244225;25463.490730184923;26628.467430651664;26654;27775 10:33:14 INFO - 2016-01-29 10:33:14,509 DEBUG : BROWSER_OUTPUT: |2;jquery.html;367.4066382791792;373.70477322914917;374.5280946008029;380.0119688809096;383.5263449639695;12589.748205035894;17104.828951710493;18248.722589418747;18485.168167432465;18704.812951870477;18336.908315458437;18468.538286542844;18619.162137703803;18663.90668046661;18724.344647937323;4204.642605378546;4329.567043295661;5351.866203344928;5598.216249725042;5629.493345598895;4308.3537469379535;6073.544484163684;6236.314005459396;6240.625562466266;6247.344028876971;6163.7226324815265;6204.317525072261;6216.502679785606;6272.968635156818;6310.085037669535;6079.6960151992225;6107.450329470346;6133.141360209552;6133.2026836511195;6139.048447490646;5430.429804870471;5459.235707001023;5484.2596249506205;5521.613487055908;5535.833924982257;21514.569708605897;21538.676919846213;21548.78451215499;21812.45468863291;21950.780492195034;2330.114556468548;2380.369202161429;2417.286900364397;2466.519028789387;2493.576092064335;13877.444902203899;14159.362828672734;14160.929195353958;14314.212718300489;14432.855671443256;1868.5982513759607;1949.0741897598668;1952.1410579345043;1979;2021.5047313408163;61616.383836161964;64047.35952640461;64383.678081609294;65060;65864.3413565863;10336.276460647832;10521.210909181842;10596.364218146937;10611.469426528643;10633.574657013633;13894.652633684238;14087;14113.435462581587;14116.364763585663;14119.85880141206;8375.413721039591;8419.621117049748;8449.36629752771;8452.408331416742;8456.619452124669;8152.796180095545;8192.631331590093;8260.628271727786;8310.875336869953;8317.750467485985;5679.290088738908;5944.078667806497;6262.091996660459;6304.653244071528;6322.968385158045;1752.1151818331662;1800.9099545022696;1805.5756897129163;1855.3135339924315;1871.737956686065;1009.5961615353771;1036.5180191211123;1056.4928834159646;1087.8205096159045;1115.6095366621616;17611.295548178186;18002.639947200983;18254.118538155664;18308.72536911921;18398.356057537923;1005.6982905128579;1008.1330056151704;1056.498163372392;1075.4676435164488;1127.6222465473993;9628.422294662203;9634.373765705206;9762.658306959222;9775.413475191512;9859.408435493893;601209;633037;638643;643626;677020;46574;46714.299285510744;49606.75196624066;78213;87525;1205.427421974555;1221.6212973978095;1230.4893469210356;1231.513552146897;1231.605886116452;15949.44176953801;16176.272067756743;16262.918685406497;16374.017558946502;16425.932314400005;37081;37446.62980331783;38006.80996594999;38813;39094.804525978325;49399.18960458241;51315.23027154521;51792.741036294574;53085;56675;9687.17658998993;10161.898381016095;10375.688729338131;10459;10501.632442864464;11933.880661193278;12054.879451205727;14661.266936653337;15765;18358.541036474195;15044.473443429428;15129.39482420691;15227.162506062274;15261.313240903964;15469.5359139226;14381.28093595337;14656.193909335088;15052.849471505582;15159.772603411178;15362.155081470626;11697.122715796178;15177.089374637557;15289.694206115593;15364.923175384052;15804;9127.954360228156;10095.495225238561;10116.544755485873;10173.949130254301;10188.745281367728;14498.710025799635;14595.85404145945;14808.925955370154;15002;15476.380944762534 10:33:14 INFO - 2016-01-29 10:33:14,510 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1504.8419915908823;1582.287970413314;1640.073358552418;1770.1326350088452;1844.4282272495527;7673.65468553915;8107.108218096005;8111.310538604226;8116.228958248957;8127.431079824415;7261.164966028909;7400;7697.191794861529;7855.332296754768;8237.299829514499;2409.807215422766;2451;2468.7654672806057;2473.888675009629;2482.863442510661;2130.1160018592263;2351.0830775997374;2382.5830479666074;2401.4836810085826;2409.8915548800346;2120.5652841167525;2337.2520793346134;2362.6574146748712;2364.432536191319;2364.609839376501;2309.0994512140196;2319.130326127702;2337.0885354711677;2398.4123889646976;2401.735809061002;2407.5546023985617;2407.7471865454227;2445.2664200739887;2445.6087026075743;2454.9877250613813;7955.761327160194;8059.63731632078;8059.919400805976;8061.395395345373;8067.435279530435;4970.353853998993;5081.237814327844;5082.263071854561;5084.059449001909;5085.745712714386;3270.525773762815;3275.836208189605;3311.3211791582908;3324.9168770780925;3341.599008119041;1104.4201794058104;1104.8895110488968;1108.1799468393413;1120.2774210634095;1137.7724455108928;11523;11553;11571.594994175248;11581.826272605833;11585.131115166312;4419.381286619876;4429.623482004065;4491.685582009228;4497.730136191773;4500.797464114123;9720.611175552898;9729.65946191894;9739.513024348755;9740.659076932274;9750;4962.255661650781;4962.851114466572;4966.925496117489;4968.403791545038;4972.453030166679;4496.797644106023;4516.254817955067;4516.593506584423;4523.163214805271;4524.819007239674;3963.5441924178513;4022.0950286185375;4037.8788636340955;4047.2714911316248;4074.8370065197655;1159.2175281684829;1226.6442731607913;1254.4480428611382;1311.9212847229005;1319.736052789446;1111.4942701070993;1112.3159257056852;1112.7051331397186;1267.1193520503346;1352.2562590575144;7758.922410775933;7862.8427431451055;7938.483998540077;7951;7966.522008679498;1145.828125781123;1185.0874826383636;1207.1127721124967;1209.2019267283727;1218.3116539155349;6149.446549810538;6181.752729890754;6215.409536094064;6216.347283535254;6230.252369715663;9721.319507634398;9954.651587194414;10065.295429319878;10097.24270679702;10100.343477673927;9754.341761900494;9816.214702823758;9873.605055797687;9906.10845023937;9964.701058968243;7788.571628560484;7874.72438464651;7915.129335773176;7976.641051152712;7977.401694872908;7583.127940286938;7681.7695469136015;7722.38220942312;7743.4966727162555;7751.961240193763;8723.302135828992;8887.37788354809;8975.50634715097;9015.729528114167;9021.128590561286;8955.865662015205;9089.636414543344;9192.17270445663;9220.907790922272;9291.256699464162;7323.523970942085;7387.963060184665;7402.925970740223;7410.407167426485;7411.0736157980255;7909.960450197712;7912.4856884302335;7938.3252423542335;7951.284384405431;8148.592570371339;6559.114519539992;7436.070491188601;7490.213527579525;7531.096268447822;7707.11368192665;6828.9658551706925;7261.164966028974;7282.380997615051;7610.733624323122;7650.043744531934;7502.549847009197;7507.211742766931;7520.548767073993;7526.172121066569;7540.547567145989;6986.54587451814;7004.299570042955;7039.1553013638695;7052.612106333996;7060.752873649398;6917.481188910751;6977.546459480118;6992.650367481708;6996.720131194696;6999.055127557918 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.5864962045546;344.7328320551571;345.65089259847554;350.89293279702537;352.17766515187037;6082.513398928087;6131.294901086377;6160.537959653027;6189.226346706661;6209;5788.5658575606785;5937.2578427696535;5994.07091900756;6000.129981152731;6080.422359875804;4651.651126165534;4657.790399432025;4677.859664210062;4679.555442232982;4693.8357157499495;4501.909961800762;4684.227102528096;4688.671792974493;4696.43642762869;4707.529247075299;4562.064776720765;4567.817287308504;4655.720656760605;4660.510646382115;4669.53304669532;4659.580637742602;4661.160991021615;4666.859994200146;4670.906581868344;4672.3692301539195;4125.938110928339;4141.544430112685;4145.647619952308;4146.730462519957;4152.647025002879;5680.630759000693;5787.768489260425;5792.189093526909;5802.100674395433;5805.535557155417;5417.079096553595;5456.8090116846115;5459.645123067027;5472.2338872557875;5473.01485732568;6466.482681385525;6478.514111441614;6488.67556622167;6492.480601551864;6498.480121590262;4580.862574122782;4597.37935378723;4599.149157405857;4600.401947746805;4605.700629459075;6609.471242300652;6664.500162487784;6747.245716113796;6750.864982700318;6759.019942108416;4718.905621887612;4721.787519561628;4722.315264286659;4723.905521889612;4723.929141062887;4779.641526885497;4780.880477988008;4781.139394908881;4782.234842425195;4785.617150627942;5457.645253058538;5459.426760190202;5467.863303417367;5473.124300111963;5473.261109750212;6314.526410519229;6456.838579035561;6479.935200648028;6495.642739649365;6536.084948107269;1660.7425848993425;1663.9584010399594;1665.991670041642;1667.0664427920403;1668.457751230855;1133.7052366384798;1139.0887290167832;1146.3981409759776;1149.1840793037038;1169.2341516306833;6382.936170638234;6387.041943708481;6389.105525226472;6396.968015159894;6400;6476.417122459001;6718.8320291993095;6722.529422940347;6734.831629209309;6738.35985581369;6245.219347581552;6310.43206111443;6416.615003099829;6426.196725409324;6435.195600549931;3615.457681347819;3649.9817500912327;3658.6707196352454;3660.0666829958723;3662.7252956028406;6815.182178138655;6978.302169782981;6979.8604027919155;6989.231184569693;6992.825179370455;6937.340952609494;6941.236463989058;6956.617386043817;6965.338292862271;6967.512274140761;6984.196817365966;6984.720611175598;6993.860122797516;6997.160340759141;6998.720051197997;6646.368594983469;6773.864522709617;6784.525083244125;6787.524873258824;6789.2192397872905;6616.239132499824;6659.766908158192;6664.033715111379;6674.632895190811;6679.432248258952;6963.1644202696;6965.965170174117;6974.895376569254;6979.720811167496;6980.7905762827195;4485.730856148511;4751.477337492804;4771.093492236464;4771.212749896228;4772.880677983078;6749.696263668048;6754.189497260164;6755.86488270222;6757.628330441873;6758.932410676027;6551.279359270381;6554.63949482783;6555.704993275219;6558.049082883051;6576.177977752781;6386.393292637192;6485.643289619116;6539;6543.607383557001;6576.967115164393;6484.675766211576;6488.837779055561;6493.350664933469;6505.186851643544;6508.60948343101;6600.8349791255605;6612.173478315211;6618.768343107968;6619.834504137435;6632.137822083098;6316.463100636497;6468.611883287018;6468.708908099241;6470;6494.09082728409 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: |5;yui.html;947.2564037230771;948.1892981500816;948.3124734567438;950.6910254167396;957.2004631293167;14318.284085795707;14662.853371466283;14664.41342346305;14670.119792812438;14690.926545367285;13339.399727012284;13581;14198.574042778733;14379.92810035951;14410.495632652859;732.5348403763621;738.3797610007592;861.0442408926102;872.6029656506274;873.0396563779855;861.0657436681208;863.7667829685981;871.3247233394106;871.5859966515918;872.4242000279817;871.8299931513358;897.7531178925782;898.420518765396;900.4012331799346;905.4883990545321;872.2193636695154;891.6567121658144;894.6689724801865;895.4895709445618;895.5925054100369;649.818050945736;657.2934095846983;662.6421732264571;675.7702381190419;676.3034074902858;14492.34784434703;14586.197759123244;14599.635009124751;14618;14621.853781462156;13171.407286672124;13416.731665366735;13451.32743362828;13620;13734.313284335843;10651.627193048284;10666.78666426667;10863.891361086446;10960.56157753689;11173;3938.0548668319684;3971.483707118085;4001.779902105383;4009.1329664194022;4039.3738970459626;47761.52238477606;47922.76038619819;48014;48207.75896120497;48224.27663585049;10103.24225683062;10644.13749051867;10872.293300935415;10899.564017439372;10955.945220273848;19397;19685.901570492057;19692.212311507665;19696.40910772679;19721.506962326057;7797.376209903194;7875.921240787518;7893.881591776128;8042.638081286356;8059.919400806034;4557.954420455753;4731.195696731564;4769.451513075971;4769.904601907942;4981.875453113701;3284.8357582121275;3317.303366293057;3319.0706602151436;3320.1367644412626;3321.6512266212185;565.6436445039681;578.0231408918913;581.5231510161711;582.3826743651742;588.3733823477983;650.4081286029785;659.2221179008816;659.4691273524859;665.3280187011154;701.0745815523562;7823.569703666353;8101.675932962616;8161.306288965505;8282.006159260807;8338.499690018618;569.8091139468324;576.7635269539469;624.7219987105785;631.3686313686313;632.6077831744348;4042.211768705133;4078.857239996586;4107.958920410758;4119.320312148522;4155.370409837275;57727.711361442925;58854.41145588575;59605.403945960854;59809.40190598038;59860.70069649624;51944.74027629838;52158;52171.21743173855;52256.38718064081;52418.475815241356;47304.290435643496;47903.5209647899;48577.27134092992;48801.755991220525;49261.261081083816;7970.721024764105;7988.680452781824;8148.796280093045;8160;8233.629486672995;38518.65184718634;38776.41835372528;39503.2099358017;39593.20813583655;40174.1965160701;46071.76964115158;46090;46193.307100394195;47278.76360618175;48240.5175948236;11160.33038017689;11200.551977920792;11646.301221926711;11737.295762254293;11791.646250612495;12685.302308373128;13091.55065690695;13094.738105238033;13095.148815326973;13325.866741332462;10897.400642964712;10922.504828243598;11023.338599684044;11136.33182009082;11616.88383116158;11022.724431889266;11434.256773309708;11490.080793536665;11774.293542387484;12057.336846473529;10166.542505587118;10389.220808439246;10544.57821687124;10640.255182137176;10659.307145035547;10350.844737328796;10453.47732613351;10540.789184216119;10597.2581919268;11198;9596.520173991412;9730.75673108178;9768.120869121813;9796.755081123029;9815.165710914367 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,833 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: __startTimestamp1454092394501__endTimestamp 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,514 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5668.36 Median:5908.29 stddev:634.81 (10.7%) stddev-sans-first:609.72 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: Values: 3331.6 3412.0 3439.1 3445.5 3467.1 5666.0 5678.9 5699.7 5704.5 5705.9 5683.5 5694.1 5707.1 5725.2 5757.8 5046.2 5080.6 5210.2 5224.9 5283.1 5224.9 5232.0 5237.9 5241.1 5245.7 5128.3 5141.7 5265.1 5299.1 5300.4 5123.2 5221.7 5222.3 5225.4 5233.5 5184.7 5191.8 5211.7 5268.0 5302.4 5373.1 5373.7 5467.4 5515.3 5561.7 6069.9 6078.0 6082.1 6088.8 6123.4 6039.6 6082.1 6106.2 6115.1 6119.4 5590.2 5638.3 5676.1 5725.5 5729.8 6200.7 6230.0 6247.4 6253.7 6258.1 6009.3 6012.3 6015.1 6023.7 6033.8 5841.9 5952.7 6089.5 6180.9 6195.7 6019.7 6020.6 6024.7 6026.8 6058.8 5830.9 5939.7 6011.8 6013.9 6023.7 4588.3 4603.4 4615.3 4618.1 4620.2 4099.8 4167.9 4169.2 4177.5 4195.3 5782.9 5785.8 5790.9 5798.3 5811.1 6084.1 6084.5 6090.4 6094.2 6104.5 5590.7 5683.1 5692.7 5707.7 5849.7 5270.6 5284.8 5308.8 5313.7 5314.8 6342.8 6360.6 6361.6 6361.8 6362.9 5943.9 6067.4 6082.5 6095.2 6183.3 6401.3 6407.9 6417.7 6428.8 6431.6 6103.2 6110.8 6115.5 6116.7 6119.3 5987.0 6111.8 6134.8 6211.0 6211.2 5993.3 6033.5 6047.0 6056.7 6090.6 5980.5 6028.0 6032.9 6040.5 6042.9 5672.6 5788.5 5833.3 5927.2 5955.1 5966.8 6017.0 6059.4 6066.9 6074.2 5640.6 5861.6 5908.3 5917.1 5940.5 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,515 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47317.56 Median:184937.50 stddev:76088.52 (41.1%) stddev-sans-first:76220.96 10:33:14 INFO - 2016-01-29 10:33:14,516 DEBUG : BROWSER_OUTPUT: Values: 558.3 582.2 604.8 621.5 683.5 32874.7 33595.3 33596.0 33629.8 40568.2 45866.5 46588.1 46676.8 46722.0 46773.0 9023.0 9201.6 9203.7 9209.3 9211.7 8332.0 8488.6 11002.3 11261.0 11265.1 10863.1 11008.1 11011.4 11015.3 11015.7 10855.8 10984.8 10985.4 10992.1 10999.9 10756.4 10837.1 10894.7 10898.4 10902.1 42231.4 42728.4 42729.1 42751.4 42755.4 3601.4 3618.1 3634.4 3822.6 3939.5 32178.5 32210.0 32488.8 32813.5 32847.8 4298.6 4301.3 4322.8 4356.9 4375.6 299777.0 300861.0 301301.0 301386.0 305194.0 56164.0 57013.1 57072.1 62820.7 63461.4 71724.6 72946.0 73430.6 73662.6 73712.3 17489.6 17953.0 17963.3 17972.7 17982.6 13409.7 13490.6 13555.5 13562.8 13564.5 20092.3 20360.0 20477.1 20481.8 20505.4 8487.4 8564.8 8594.1 8659.6 8701.6 985.6 1017.2 1064.4 1136.5 1138.1 29451.0 29479.0 29775.3 30392.0 30460.5 1142.6 1176.1 1187.8 1194.3 1229.2 13575.5 15524.9 15577.8 15734.4 15809.8 329924.0 336279.0 337229.0 337456.0 337657.0 56865.0 56937.7 57017.7 57022.4 57147.4 1354.1 1405.0 1440.6 1454.7 1538.8 25517.2 26047.9 26439.5 27355.2 27905.6 44408.0 44751.6 44752.0 44758.0 44861.0 224485.0 224945.0 225591.0 225731.0 227669.0 34246.8 34629.5 34872.0 34965.3 35141.8 44340.8 46019.1 46111.8 46142.5 46166.5 38059.8 38348.4 38421.0 38562.8 39376.2 38300.4 38519.3 38605.0 39499.0 39549.0 37916.2 38026.6 38305.0 38613.6 38759.6 29547.0 30649.7 30955.7 30986.8 31019.7 24424.8 25463.5 26628.5 26654.0 27775.0 10:33:14 INFO - 2016-01-29 10:33:14,516 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,516 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31975.09 Median:1965.57 stddev:104126.69 (5297.5%) stddev-sans-first:104391.74 10:33:14 INFO - 2016-01-29 10:33:14,517 DEBUG : BROWSER_OUTPUT: Values: 367.4 373.7 374.5 380.0 383.5 12589.7 17104.8 18248.7 18485.2 18704.8 18336.9 18468.5 18619.2 18663.9 18724.3 4204.6 4329.6 5351.9 5598.2 5629.5 4308.4 6073.5 6236.3 6240.6 6247.3 6163.7 6204.3 6216.5 6273.0 6310.1 6079.7 6107.5 6133.1 6133.2 6139.0 5430.4 5459.2 5484.3 5521.6 5535.8 21514.6 21538.7 21548.8 21812.5 21950.8 2330.1 2380.4 2417.3 2466.5 2493.6 13877.4 14159.4 14160.9 14314.2 14432.9 1868.6 1949.1 1952.1 1979.0 2021.5 61616.4 64047.4 64383.7 65060.0 65864.3 10336.3 10521.2 10596.4 10611.5 10633.6 13894.7 14087.0 14113.4 14116.4 14119.9 8375.4 8419.6 8449.4 8452.4 8456.6 8152.8 8192.6 8260.6 8310.9 8317.8 5679.3 5944.1 6262.1 6304.7 6323.0 1752.1 1800.9 1805.6 1855.3 1871.7 1009.6 1036.5 1056.5 1087.8 1115.6 17611.3 18002.6 18254.1 18308.7 18398.4 1005.7 1008.1 1056.5 1075.5 1127.6 9628.4 9634.4 9762.7 9775.4 9859.4 601209.0 633037.0 638643.0 643626.0 677020.0 46574.0 46714.3 49606.8 78213.0 87525.0 1205.4 1221.6 1230.5 1231.5 1231.6 15949.4 16176.3 16262.9 16374.0 16425.9 37081.0 37446.6 38006.8 38813.0 39094.8 49399.2 51315.2 51792.7 53085.0 56675.0 9687.2 10161.9 10375.7 10459.0 10501.6 11933.9 12054.9 14661.3 15765.0 18358.5 15044.5 15129.4 15227.2 15261.3 15469.5 14381.3 14656.2 15052.8 15159.8 15362.2 11697.1 15177.1 15289.7 15364.9 15804.0 9128.0 10095.5 10116.5 10173.9 10188.7 14498.7 14595.9 14808.9 15002.0 15476.4 10:33:14 INFO - 2016-01-29 10:33:14,517 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,517 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5802.49 Median:6215.88 stddev:3003.60 (48.3%) stddev-sans-first:2994.66 10:33:14 INFO - 2016-01-29 10:33:14,517 DEBUG : BROWSER_OUTPUT: Values: 1504.8 1582.3 1640.1 1770.1 1844.4 7673.7 8107.1 8111.3 8116.2 8127.4 7261.2 7400.0 7697.2 7855.3 8237.3 2409.8 2451.0 2468.8 2473.9 2482.9 2130.1 2351.1 2382.6 2401.5 2409.9 2120.6 2337.3 2362.7 2364.4 2364.6 2309.1 2319.1 2337.1 2398.4 2401.7 2407.6 2407.7 2445.3 2445.6 2455.0 7955.8 8059.6 8059.9 8061.4 8067.4 4970.4 5081.2 5082.3 5084.1 5085.7 3270.5 3275.8 3311.3 3324.9 3341.6 1104.4 1104.9 1108.2 1120.3 1137.8 11523.0 11553.0 11571.6 11581.8 11585.1 4419.4 4429.6 4491.7 4497.7 4500.8 9720.6 9729.7 9739.5 9740.7 9750.0 4962.3 4962.9 4966.9 4968.4 4972.5 4496.8 4516.3 4516.6 4523.2 4524.8 3963.5 4022.1 4037.9 4047.3 4074.8 1159.2 1226.6 1254.4 1311.9 1319.7 1111.5 1112.3 1112.7 1267.1 1352.3 7758.9 7862.8 7938.5 7951.0 7966.5 1145.8 1185.1 1207.1 1209.2 1218.3 6149.4 6181.8 6215.4 6216.3 6230.3 9721.3 9954.7 10065.3 10097.2 10100.3 9754.3 9816.2 9873.6 9906.1 9964.7 7788.6 7874.7 7915.1 7976.6 7977.4 7583.1 7681.8 7722.4 7743.5 7752.0 8723.3 8887.4 8975.5 9015.7 9021.1 8955.9 9089.6 9192.2 9220.9 9291.3 7323.5 7388.0 7402.9 7410.4 7411.1 7910.0 7912.5 7938.3 7951.3 8148.6 6559.1 7436.1 7490.2 7531.1 7707.1 6829.0 7261.2 7282.4 7610.7 7650.0 7502.5 7507.2 7520.5 7526.2 7540.5 6986.5 7004.3 7039.2 7052.6 7060.8 6917.5 6977.5 6992.7 6996.7 6999.1 10:33:14 INFO - 2016-01-29 10:33:14,518 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,518 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5470.46 Median:6277.83 stddev:1640.10 (26.1%) stddev-sans-first:1598.94 10:33:14 INFO - 2016-01-29 10:33:14,518 DEBUG : BROWSER_OUTPUT: Values: 344.6 344.7 345.7 350.9 352.2 6082.5 6131.3 6160.5 6189.2 6209.0 5788.6 5937.3 5994.1 6000.1 6080.4 4651.7 4657.8 4677.9 4679.6 4693.8 4501.9 4684.2 4688.7 4696.4 4707.5 4562.1 4567.8 4655.7 4660.5 4669.5 4659.6 4661.2 4666.9 4670.9 4672.4 4125.9 4141.5 4145.6 4146.7 4152.6 5680.6 5787.8 5792.2 5802.1 5805.5 5417.1 5456.8 5459.6 5472.2 5473.0 6466.5 6478.5 6488.7 6492.5 6498.5 4580.9 4597.4 4599.1 4600.4 4605.7 6609.5 6664.5 6747.2 6750.9 6759.0 4718.9 4721.8 4722.3 4723.9 4723.9 4779.6 4780.9 4781.1 4782.2 4785.6 5457.6 5459.4 5467.9 5473.1 5473.3 6314.5 6456.8 6479.9 6495.6 6536.1 1660.7 1664.0 1666.0 1667.1 1668.5 1133.7 1139.1 1146.4 1149.2 1169.2 6382.9 6387.0 6389.1 6397.0 6400.0 6476.4 6718.8 6722.5 6734.8 6738.4 6245.2 6310.4 6416.6 6426.2 6435.2 3615.5 3650.0 3658.7 3660.1 3662.7 6815.2 6978.3 6979.9 6989.2 6992.8 6937.3 6941.2 6956.6 6965.3 6967.5 6984.2 6984.7 6993.9 6997.2 6998.7 6646.4 6773.9 6784.5 6787.5 6789.2 6616.2 6659.8 6664.0 6674.6 6679.4 6963.2 6966.0 6974.9 6979.7 6980.8 4485.7 4751.5 4771.1 4771.2 4772.9 6749.7 6754.2 6755.9 6757.6 6758.9 6551.3 6554.6 6555.7 6558.0 6576.2 6386.4 6485.6 6539.0 6543.6 6577.0 6484.7 6488.8 6493.4 6505.2 6508.6 6600.8 6612.2 6618.8 6619.8 6632.1 6316.5 6468.6 6468.7 6470.0 6494.1 10:33:14 INFO - 2016-01-29 10:33:14,519 DEBUG : BROWSER_OUTPUT: 10:33:14 INFO - 2016-01-29 10:33:14,519 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14362.70 Median:26017.74 stddev:16500.47 (63.4%) stddev-sans-first:16516.00 10:33:14 INFO - 2016-01-29 10:33:14,519 DEBUG : BROWSER_OUTPUT: Values: 947.3 948.2 948.3 950.7 957.2 14318.3 14662.9 14664.4 14670.1 14690.9 13339.4 13581.0 14198.6 14379.9 14410.5 732.5 738.4 861.0 872.6 873.0 861.1 863.8 871.3 871.6 872.4 871.8 897.8 898.4 900.4 905.5 872.2 891.7 894.7 895.5 895.6 649.8 657.3 662.6 675.8 676.3 14492.3 14586.2 14599.6 14618.0 14621.9 13171.4 13416.7 13451.3 13620.0 13734.3 10651.6 10666.8 10863.9 10960.6 11173.0 3938.1 3971.5 4001.8 4009.1 4039.4 47761.5 47922.8 48014.0 48207.8 48224.3 10103.2 10644.1 10872.3 10899.6 10955.9 19397.0 19685.9 19692.2 19696.4 19721.5 7797.4 7875.9 7893.9 8042.6 8059.9 4558.0 4731.2 4769.5 4769.9 4981.9 3284.8 3317.3 3319.1 3320.1 3321.7 565.6 578.0 581.5 582.4 588.4 650.4 659.2 659.5 665.3 701.1 7823.6 8101.7 8161.3 8282.0 8338.5 569.8 576.8 624.7 631.4 632.6 4042.2 4078.9 4108.0 4119.3 4155.4 57727.7 58854.4 59605.4 59809.4 59860.7 51944.7 52158.0 52171.2 52256.4 52418.5 47304.3 47903.5 48577.3 48801.8 49261.3 7970.7 7988.7 8148.8 8160.0 8233.6 38518.7 38776.4 39503.2 39593.2 40174.2 46071.8 46090.0 46193.3 47278.8 48240.5 11160.3 11200.6 11646.3 11737.3 11791.6 12685.3 13091.6 13094.7 13095.1 13325.9 10897.4 10922.5 11023.3 11136.3 11616.9 11022.7 11434.3 11490.1 11774.3 12057.3 10166.5 10389.2 10544.6 10640.3 10659.3 10350.8 10453.5 10540.8 10597.3 11198.0 9596.5 9730.8 9768.1 9796.8 9815.2 10:33:14 INFO - 2016-01-29 10:33:14,519 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:33:14 INFO - 2016-01-29 10:33:14,519 DEBUG : BROWSER_OUTPUT: 10:33:15 INFO - 2016-01-29 10:33:15,121 INFO : Browser exited with error code: 0 10:33:15 INFO - 2016-01-29 10:33:15,141 INFO : Completed test dromaeo_css (00:18:30) 10:33:15 INFO - 2016-01-29 10:33:15,142 INFO : Starting test kraken 10:33:15 INFO - 2016-01-29 10:33:15,142 DEBUG : operating with platform_type : linux_ 10:33:15 INFO - 2016-01-29 10:33:15,142 INFO : Initialising browser for kraken test... 10:33:15 INFO - 2016-01-29 10:33:15,148 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJNKK7/profile http://localhost:44659/getInfo.html 10:33:19 INFO - 2016-01-29 10:33:19,025 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:33:19 INFO - 2016-01-29 10:33:19,025 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:33:19 INFO - 2016-01-29 10:33:19,025 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:33:19 INFO - 2016-01-29 10:33:19,026 DEBUG : BROWSER_OUTPUT: __metrics 10:33:19 INFO - 2016-01-29 10:33:19,187 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:20 INFO - 2016-01-29 10:33:20,153 INFO : Browser initialized. 10:33:20 INFO - 2016-01-29 10:33:20,153 INFO : Running cycle 1/1 for kraken test... 10:33:20 INFO - 2016-01-29 10:33:20,153 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJNKK7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:33:31 INFO - 2016-01-29 10:33:31,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 135049216 10:33:31 INFO - 2016-01-29 10:33:31,923 DEBUG : BROWSER_OUTPUT: 10:33:34 INFO - 2016-01-29 10:33:34,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44659/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:34 INFO - 2016-01-29 10:33:34,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 165638144 10:33:34 INFO - 2016-01-29 10:33:34,926 DEBUG : BROWSER_OUTPUT: 10:33:37 INFO - 2016-01-29 10:33:37,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44659/tests/kraken/driver.html?testName=audio-dft) 10:33:38 INFO - 2016-01-29 10:33:38,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 162508800 10:33:38 INFO - 2016-01-29 10:33:38,062 DEBUG : BROWSER_OUTPUT: 10:33:40 INFO - 2016-01-29 10:33:40,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44659/tests/kraken/driver.html?testName=audio-fft) 10:33:41 INFO - 2016-01-29 10:33:41,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 158445568 10:33:41 INFO - 2016-01-29 10:33:41,411 DEBUG : BROWSER_OUTPUT: 10:33:43 INFO - 2016-01-29 10:33:43,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44659/tests/kraken/driver.html?testName=audio-oscillator) 10:33:43 INFO - 2016-01-29 10:33:43,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 159580160 10:33:43 INFO - 2016-01-29 10:33:43,991 DEBUG : BROWSER_OUTPUT: 10:33:46 INFO - 2016-01-29 10:33:46,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:46 INFO - 2016-01-29 10:33:46,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 158724096 10:33:46 INFO - 2016-01-29 10:33:46,719 DEBUG : BROWSER_OUTPUT: 10:33:49 INFO - 2016-01-29 10:33:49,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44659/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:50 INFO - 2016-01-29 10:33:50,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 159248384 10:33:50 INFO - 2016-01-29 10:33:50,113 DEBUG : BROWSER_OUTPUT: 10:33:53 INFO - 2016-01-29 10:33:53,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44659/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:54 INFO - 2016-01-29 10:33:54,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 160600064 10:33:54 INFO - 2016-01-29 10:33:54,072 DEBUG : BROWSER_OUTPUT: 10:33:56 INFO - 2016-01-29 10:33:56,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44659/tests/kraken/driver.html?testName=json-parse-financial) 10:33:57 INFO - 2016-01-29 10:33:57,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 158429184 10:33:57 INFO - 2016-01-29 10:33:57,325 DEBUG : BROWSER_OUTPUT: 10:33:58 INFO - 2016-01-29 10:33:58,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:59 INFO - 2016-01-29 10:33:59,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 164990976 10:33:59 INFO - 2016-01-29 10:33:59,433 DEBUG : BROWSER_OUTPUT: 10:34:01 INFO - 2016-01-29 10:34:01,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:01 INFO - 2016-01-29 10:34:01,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 163258368 10:34:01 INFO - 2016-01-29 10:34:01,759 DEBUG : BROWSER_OUTPUT: 10:34:03 INFO - 2016-01-29 10:34:03,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:04 INFO - 2016-01-29 10:34:04,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 167956480 10:34:04 INFO - 2016-01-29 10:34:04,297 DEBUG : BROWSER_OUTPUT: 10:34:06 INFO - 2016-01-29 10:34:06,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:07 INFO - 2016-01-29 10:34:07,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 174542848 10:34:07 INFO - 2016-01-29 10:34:07,263 DEBUG : BROWSER_OUTPUT: 10:34:09 INFO - 2016-01-29 10:34:09,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:10 INFO - 2016-01-29 10:34:10,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 173383680 10:34:10 INFO - 2016-01-29 10:34:10,305 DEBUG : BROWSER_OUTPUT: 10:34:11 INFO - 2016-01-29 10:34:11,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44659/tests/kraken/driver.html?testName=ai-astar) 10:34:12 INFO - 2016-01-29 10:34:12,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 231743488 10:34:12 INFO - 2016-01-29 10:34:12,187 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,188 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;109;110;110;100;112;109;110 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;121;149;155;124;149;146;122;169;128 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;161;159;161;162;160;158;160;159 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;78;74;151;74;73;71;71;154;71 10:34:12 INFO - 2016-01-29 10:34:12,189 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;137;92;93;92;145;90;91;134 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;110;109 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;154;146;146;146;145;145;146;145;146 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;98;95;95;95;96;96;96;95 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;58;57;56;56;57;57;54;56 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;62;64;63;64;63;64;64;65 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;86;79;79;78;79;79;78;78;79 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;115;113;110;117;121;118;112;119;118 10:34:12 INFO - 2016-01-29 10:34:12,190 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;142;141;140;142;129;132;142;139;131 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;66;64;64;62;63;63;62;62 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1454092452187__endTimestamp 10:34:12 INFO - 2016-01-29 10:34:12,191 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,195 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:34:12 INFO - 2016-01-29 10:34:12,195 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:34:12 INFO - 2016-01-29 10:34:12,195 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,195 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.63 (3.3%) stddev-sans-first:3.84 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 109.0 110.0 110.0 100.0 112.0 109.0 110.0 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:149.00 stddev:16.57 (11.1%) stddev-sans-first:17.13 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: Values: 152.0 121.0 149.0 155.0 124.0 149.0 146.0 122.0 169.0 128.0 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 161.0 159.0 161.0 162.0 160.0 158.0 160.0 159.0 10:34:12 INFO - 2016-01-29 10:34:12,196 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.50 stddev:33.59 (46.3%) stddev-sans-first:35.07 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: Values: 72.0 78.0 74.0 151.0 74.0 73.0 71.0 71.0 154.0 71.0 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.00 stddev:22.79 (24.8%) stddev-sans-first:23.61 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 137.0 92.0 93.0 92.0 145.0 90.0 91.0 134.0 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 10:34:12 INFO - 2016-01-29 10:34:12,197 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:2.72 (1.9%) stddev-sans-first:2.83 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: Values: 145.0 154.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 98.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 10:34:12 INFO - 2016-01-29 10:34:12,198 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,199 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.08 (1.9%) stddev-sans-first:1.13 10:34:12 INFO - 2016-01-29 10:34:12,199 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 58.0 57.0 56.0 56.0 57.0 57.0 54.0 56.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 62.0 64.0 63.0 64.0 63.0 64.0 64.0 65.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:2.60 (3.3%) stddev-sans-first:2.51 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: Values: 76.0 86.0 79.0 79.0 78.0 79.0 79.0 78.0 78.0 79.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.00 stddev:5.13 (4.3%) stddev-sans-first:3.62 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: Values: 128.0 115.0 113.0 110.0 117.0 121.0 118.0 112.0 119.0 118.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:140.50 stddev:5.43 (3.9%) stddev-sans-first:5.32 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: Values: 131.0 142.0 141.0 140.0 142.0 129.0 132.0 142.0 139.0 131.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 66.0 64.0 64.0 62.0 63.0 63.0 62.0 62.0 10:34:12 INFO - 2016-01-29 10:34:12,200 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:34:12 INFO - 2016-01-29 10:34:12,201 DEBUG : BROWSER_OUTPUT: 10:34:12 INFO - 2016-01-29 10:34:12,897 INFO : Browser exited with error code: 0 10:34:12 INFO - 2016-01-29 10:34:12,945 INFO : Completed test kraken (00:00:57) 10:34:12 INFO - 2016-01-29 10:34:12,945 INFO : Starting test v8_7 10:34:12 INFO - 2016-01-29 10:34:12,945 DEBUG : operating with platform_type : linux_ 10:34:12 INFO - 2016-01-29 10:34:12,946 INFO : Initialising browser for v8_7 test... 10:34:12 INFO - 2016-01-29 10:34:12,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqepREG/profile http://localhost:44659/getInfo.html 10:34:17 INFO - 2016-01-29 10:34:17,116 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:34:17 INFO - 2016-01-29 10:34:17,117 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:34:17 INFO - 2016-01-29 10:34:17,117 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:34:17 INFO - 2016-01-29 10:34:17,117 DEBUG : BROWSER_OUTPUT: __metrics 10:34:17 INFO - 2016-01-29 10:34:17,258 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:18 INFO - 2016-01-29 10:34:18,021 INFO : Browser initialized. 10:34:18 INFO - 2016-01-29 10:34:18,021 INFO : Running cycle 1/1 for v8_7 test... 10:34:18 INFO - 2016-01-29 10:34:18,021 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqepREG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:34:29 INFO - 2016-01-29 10:34:29,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 134455296 10:34:29 INFO - 2016-01-29 10:34:29,805 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44659/tests/v8_7/run.html (next: http://localhost:44659/tests/v8_7/run.html) 10:34:51 INFO - 2016-01-29 10:34:51,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 429744128 10:34:51 INFO - 2016-01-29 10:34:51,421 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,422 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:34:51 INFO - 2016-01-29 10:34:51,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:34:51 INFO - 2016-01-29 10:34:51,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:34:51 INFO - 2016-01-29 10:34:51,422 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:34:51 INFO - 2016-01-29 10:34:51,422 DEBUG : BROWSER_OUTPUT: |0;Richards;164.14970453053184 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.85328058028355 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1002.0040080160321 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |5;Earley;542.0054200542005 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |6;Boyer;10600 10:34:51 INFO - 2016-01-29 10:34:51,423 DEBUG : BROWSER_OUTPUT: |7;RegExp;24926.829268292684 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: |8;Splay;513.8603696098562 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: __startTimestamp1454092491421__endTimestamp 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:34:51 INFO - 2016-01-29 10:34:51,424 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:34:51 INFO - 2016-01-29 10:34:51,425 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,425 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.15 Median:164.15 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,425 DEBUG : BROWSER_OUTPUT: Values: 164.1 10:34:51 INFO - 2016-01-29 10:34:51,425 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,425 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.85 Median:164.85 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,426 DEBUG : BROWSER_OUTPUT: Values: 164.9 10:34:51 INFO - 2016-01-29 10:34:51,426 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,426 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: Values: 278.5 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: Values: 5148.7 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1002.00 Median:1002.00 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: Values: 1002.0 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.01 Median:542.01 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: Values: 542.0 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10600.00 Median:10600.00 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: Values: 10600.0 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,427 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: Values: 24926.8 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:513.86 Median:513.86 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: Values: 513.9 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:34:51 INFO - 2016-01-29 10:34:51,428 DEBUG : BROWSER_OUTPUT: 10:34:52 INFO - 2016-01-29 10:34:52,125 INFO : Browser exited with error code: 0 10:34:52 INFO - 2016-01-29 10:34:52,137 INFO : Completed test v8_7 (00:00:39) 10:34:52 INFO - 2016-01-29 10:34:52,463 INFO : Completed test suite (00:20:07) 10:34:52 INFO - 2016-01-29 10:34:52,464 DEBUG : Working with test: dromaeo_css 10:34:52 INFO - 2016-01-29 10:34:52,464 DEBUG : Generating results file: dromaeo_css 10:34:52 INFO - 2016-01-29 10:34:52,465 DEBUG : Working with test: kraken 10:34:52 INFO - 2016-01-29 10:34:52,465 DEBUG : Generating results file: kraken 10:34:52 INFO - 2016-01-29 10:34:52,465 INFO : javascript benchmark 10:34:52 INFO - 2016-01-29 10:34:52,465 DEBUG : Working with test: v8_7 10:34:52 INFO - 2016-01-29 10:34:52,466 DEBUG : Generating results file: v8_7 10:34:52 INFO - 2016-01-29 10:34:52,466 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:52 INFO - 2016-01-29 10:34:52,650 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:34:52 INFO - 2016-01-29 10:34:52,650 DEBUG : process_Request line: dromaeo_css 7402.50 graph.html#tests=[[72,53,35]] 10:34:52 INFO - 2016-01-29 10:34:52,650 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:52 INFO - 2016-01-29 10:34:52,684 DEBUG : process_Request line: kraken 1472.40 graph.html#tests=[[232,53,35]] 10:34:52 INFO - 2016-01-29 10:34:52,684 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:34:52 INFO - 2016-01-29 10:34:52,713 DEBUG : process_Request line: v8_7 23195.13 graph.html#tests=[[230,53,35]] 10:34:52 INFO - 2016-01-29 10:34:52,715 INFO : javascript benchmark 10:34:52 INFO - 2016-01-29 10:34:52,718 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3331.633520312766, 3412.0275721419403, 3439.105832483555, 3445.4659527773188, 3467.1332166958255, 5666.036773748462, 5678.943210567893, 5699.6580205187665, 5704.515116215116, 5705.857353566153, 5683.545316374691, 5694.088945768678, 5707.086866101425, 5725.227094342263, 5757.827265182041, 5046.21783623539, 5080.568151707109, 5210.2445145453985, 5224.895502089956, 5283.07546179419, 5224.869378265555, 5232.0, 5237.947620523803, 5241.056609810233, 5245.659032162897, 5128.307678463397, 5141.665791723544, 5265.104932161542, 5299.125644268691, 5300.443453437391, 5123.205903085028, 5221.686698798084, 5222.3472065991755, 5225.399079105913, 5233.450487698775, 5184.7407629618365, 5191.766370513336, 5211.7133557654315, 5268.0, 5302.443243459458, 5373.113436283009, 5373.704446255454, 5467.425920278353, 5515.255440515519, 5561.666300021971, 6069.939300607026, 6078.0, 6082.148499210114, 6088.786892458787, 6123.448889599913, 6039.63762174271, 6082.148499210114, 6106.236720409949, 6115.082737589352, 6119.388061193889, 5590.245316882209, 5638.2670252866865, 5676.063449530864, 5725.51333136688, 5729.7708091676695, 6200.720967556471, 6229.968850155811, 6247.437730604267, 6253.7185826637915, 6258.061290806416, 6009.308929473166, 6012.278526576752, 6015.06766451192, 6023.698815059317, 6033.78881739137, 5841.9415805842245, 5952.672603006876, 6089.482393996472, 6180.8763824723255, 6195.690215489208, 6019.729112189962, 6020.57855950088, 6024.689883715691, 6026.849328766816, 6058.787942421994, 5830.883382332415, 5939.732712027882, 6011.819645410645, 6013.939860601426, 6023.668698221552, 4588.311753237042, 4603.424571928509, 4615.284630882219, 4618.053299073682, 4620.168369693488, 4099.836006559704, 4167.854125105607, 4169.207850508394, 4177.540470548237, 4195.286801243735, 5782.88434231313, 5785.826425207167, 5790.94209057904, 5798.275215598051, 5811.070228763378, 6084.056971169476, 6084.543659225487, 6090.421409966046, 6094.177286066413, 6104.4505994460715, 5590.664560126405, 5683.119116536944, 5692.686902220335, 5707.71461426927, 5849.707514624251, 5270.578353731692, 5284.762185701576, 5308.814191503279, 5313.734313284321, 5314.7874085036165, 6342.809715708536, 6360.618362898241, 6361.61830290184, 6361.777337793155, 6362.936370636235, 5943.940560594512, 6067.393260674074, 6082.452579267887, 6095.238095238095, 6183.288921774054, 6401.29585745577, 6407.8718425630295, 6417.743290268337, 6428.774992875227, 6431.5819471734185, 6103.206583144163, 6110.7861224856915, 6115.541334399849, 6116.694165291807, 6119.265688117454, 5987.0, 6111.84720381994, 6134.8159555213415, 6210.968945155245, 6211.16149319836, 5993.280806303097, 6033.497341086497, 6047.03247480401, 6056.727447264796, 6090.634561926298, 5980.491658208927, 6028.0355143176885, 6032.939670603413, 6040.516758659384, 6042.939570604238, 5672.5745569081655, 5788.450097240755, 5833.300003999547, 5927.229460170151, 5955.136505206808, 5966.76132954677, 6017.037274036134, 6059.363766804422, 6066.878662426815, 6074.179985701874, 5640.5769567281795, 5861.560382971209, 5908.291005079418, 5917.082852157922, 5940.465358117617], "unit": "ms", "name": "dojo.html", "value": 5626.862302421883}, {"lowerIsBetter": false, "replicates": [558.3305915313215, 582.1616871704746, 604.8336707405463, 621.5276389943641, 683.4668958212593, 32874.67125328746, 33595.32809343815, 33596.0, 33629.831850840776, 40568.188636227256, 45866.54133458665, 46588.068238635205, 46676.766616166955, 46722.0, 46773.0, 9023.0, 9201.631934722604, 9203.723888283363, 9209.263258939269, 9211.677591284306, 8332.0, 8488.618012189467, 11002.33985960845, 11261.042811361043, 11265.098792096613, 10863.076638485738, 11008.064314533234, 11011.394373309466, 11015.339079655207, 11015.724606884813, 10855.837162442569, 10984.835227471594, 10985.395803230818, 10992.120630349553, 10999.890001100006, 10756.354618722824, 10837.133029357712, 10894.727631809188, 10898.400587967659, 10902.127829773599, 42231.366529502084, 42728.35907461391, 42729.14541709179, 42751.35872961908, 42755.35866961998, 3601.441776524643, 3618.1316484043905, 3634.436662317345, 3822.57951625321, 3939.4878665773554, 32178.51378011613, 32210.0, 32488.837555812304, 32813.507797383056, 32847.83576082104, 4298.591633794785, 4301.333293339538, 4322.783860806947, 4356.912861742748, 4375.6280716138845, 299777.0, 300861.0, 301301.0, 301386.0, 305193.9999999978, 56164.0, 57013.14480282799, 57072.14391784126, 62820.68589657023, 63461.36538634647, 71724.64137679279, 72946.0, 73430.63284683542, 73662.63168684123, 73712.26287737161, 17489.56276093108, 17953.0, 17963.281468741105, 17972.730409043874, 17982.550436238937, 13409.66475838112, 13490.595282141552, 13555.525556605471, 13562.796558051637, 13564.525241616497, 20092.296769612993, 20360.0, 20477.07853146612, 20481.79518204799, 20505.38483845487, 8487.448315859572, 8564.785880353042, 8594.14058594148, 8659.610317535726, 8701.608427620773, 985.5712764947127, 1017.2269075502523, 1064.4252103863828, 1136.4601814138384, 1138.1057039238326, 29451.0, 29479.0, 29775.255618609706, 30392.0, 30460.54309185364, 1142.6115120858947, 1176.1472932124314, 1187.8099504079478, 1194.2535915053093, 1229.1764517773113, 13575.456981720818, 15524.92237538805, 15577.766333505006, 15734.449294274646, 15809.841901581067, 329924.0, 336279.0, 337229.0, 337456.0, 337657.0, 56865.0, 56937.715311424006, 57017.71491142518, 57022.42977570171, 57147.428365723645, 1354.0927578522414, 1405.0375492787473, 1440.553428437188, 1454.6508837879044, 1538.830728619851, 25517.23448296554, 26047.869760651076, 26439.471210576066, 27355.179344619693, 27905.58141627918, 44408.0, 44751.552484476044, 44752.0, 44758.0, 44861.0, 224485.0, 224945.0, 225591.0, 225731.0, 227669.0, 34246.828765856015, 34629.48055779115, 34872.0, 34965.300693986486, 35141.824290879405, 44340.778296108314, 46019.07961840677, 46111.76944115258, 46142.53857461383, 46166.53833461623, 38059.809700951315, 38348.424773628976, 38421.0, 38562.80718596389, 39376.2124757509, 38300.425493618175, 38519.336796639924, 38605.0, 39499.0, 39549.0, 37916.24167516579, 38026.619733802305, 38305.0, 38613.613863861, 38759.6124038756, 29547.0, 30649.693503064686, 30955.69044309528, 30986.845065774527, 31019.68980310168, 24424.75575244225, 25463.490730184923, 26628.467430651664, 26654.0, 27775.0], "unit": "ms", "name": "ext.html", "value": 19785.091367029556}, {"lowerIsBetter": false, "replicates": [367.4066382791792, 373.70477322914917, 374.5280946008029, 380.0119688809096, 383.5263449639695, 12589.748205035894, 17104.828951710493, 18248.722589418747, 18485.168167432465, 18704.812951870477, 18336.908315458437, 18468.538286542844, 18619.162137703803, 18663.90668046661, 18724.344647937323, 4204.642605378546, 4329.567043295661, 5351.866203344928, 5598.216249725042, 5629.493345598895, 4308.3537469379535, 6073.544484163684, 6236.314005459396, 6240.625562466266, 6247.344028876971, 6163.7226324815265, 6204.317525072261, 6216.502679785606, 6272.968635156818, 6310.085037669535, 6079.6960151992225, 6107.450329470346, 6133.141360209552, 6133.2026836511195, 6139.048447490646, 5430.429804870471, 5459.235707001023, 5484.2596249506205, 5521.613487055908, 5535.833924982257, 21514.569708605897, 21538.676919846213, 21548.78451215499, 21812.45468863291, 21950.780492195034, 2330.114556468548, 2380.369202161429, 2417.286900364397, 2466.519028789387, 2493.576092064335, 13877.444902203899, 14159.362828672734, 14160.929195353958, 14314.212718300489, 14432.855671443256, 1868.5982513759607, 1949.0741897598668, 1952.1410579345043, 1979.0, 2021.5047313408163, 61616.383836161964, 64047.35952640461, 64383.678081609294, 65060.0, 65864.3413565863, 10336.276460647832, 10521.210909181842, 10596.364218146937, 10611.469426528643, 10633.574657013633, 13894.652633684238, 14087.0, 14113.435462581587, 14116.364763585663, 14119.85880141206, 8375.413721039591, 8419.621117049748, 8449.36629752771, 8452.408331416742, 8456.619452124669, 8152.796180095545, 8192.631331590093, 8260.628271727786, 8310.875336869953, 8317.750467485985, 5679.290088738908, 5944.078667806497, 6262.091996660459, 6304.653244071528, 6322.968385158045, 1752.1151818331662, 1800.9099545022696, 1805.5756897129163, 1855.3135339924315, 1871.737956686065, 1009.5961615353771, 1036.5180191211123, 1056.4928834159646, 1087.8205096159045, 1115.6095366621616, 17611.295548178186, 18002.639947200983, 18254.118538155664, 18308.72536911921, 18398.356057537923, 1005.6982905128579, 1008.1330056151704, 1056.498163372392, 1075.4676435164488, 1127.6222465473993, 9628.422294662203, 9634.373765705206, 9762.658306959222, 9775.413475191512, 9859.408435493893, 601209.0, 633037.0, 638643.0, 643626.0, 677020.0, 46574.0, 46714.299285510744, 49606.75196624066, 78213.0, 87525.0, 1205.427421974555, 1221.6212973978095, 1230.4893469210356, 1231.513552146897, 1231.605886116452, 15949.44176953801, 16176.272067756743, 16262.918685406497, 16374.017558946502, 16425.932314400005, 37081.0, 37446.62980331783, 38006.80996594999, 38813.0, 39094.804525978325, 49399.18960458241, 51315.23027154521, 51792.741036294574, 53085.0, 56675.0, 9687.17658998993, 10161.898381016095, 10375.688729338131, 10459.0, 10501.632442864464, 11933.880661193278, 12054.879451205727, 14661.266936653337, 15765.0, 18358.541036474195, 15044.473443429428, 15129.39482420691, 15227.162506062274, 15261.313240903964, 15469.5359139226, 14381.28093595337, 14656.193909335088, 15052.849471505582, 15159.772603411178, 15362.155081470626, 11697.122715796178, 15177.089374637557, 15289.694206115593, 15364.923175384052, 15804.0, 9127.954360228156, 10095.495225238561, 10116.544755485873, 10173.949130254301, 10188.745281367728, 14498.710025799635, 14595.85404145945, 14808.925955370154, 15002.0, 15476.380944762534], "unit": "ms", "name": "jquery.html", "value": 9529.951257628813}, {"lowerIsBetter": false, "replicates": [1504.8419915908823, 1582.287970413314, 1640.073358552418, 1770.1326350088452, 1844.4282272495527, 7673.65468553915, 8107.108218096005, 8111.310538604226, 8116.228958248957, 8127.431079824415, 7261.164966028909, 7400.0, 7697.191794861529, 7855.332296754768, 8237.299829514499, 2409.807215422766, 2451.0, 2468.7654672806057, 2473.888675009629, 2482.863442510661, 2130.1160018592263, 2351.0830775997374, 2382.5830479666074, 2401.4836810085826, 2409.8915548800346, 2120.5652841167525, 2337.2520793346134, 2362.6574146748712, 2364.432536191319, 2364.609839376501, 2309.0994512140196, 2319.130326127702, 2337.0885354711677, 2398.4123889646976, 2401.735809061002, 2407.5546023985617, 2407.7471865454227, 2445.2664200739887, 2445.6087026075743, 2454.9877250613813, 7955.761327160194, 8059.63731632078, 8059.919400805976, 8061.395395345373, 8067.435279530435, 4970.353853998993, 5081.237814327844, 5082.263071854561, 5084.059449001909, 5085.745712714386, 3270.525773762815, 3275.836208189605, 3311.3211791582908, 3324.9168770780925, 3341.599008119041, 1104.4201794058104, 1104.8895110488968, 1108.1799468393413, 1120.2774210634095, 1137.7724455108928, 11523.0, 11553.0, 11571.594994175248, 11581.826272605833, 11585.131115166312, 4419.381286619876, 4429.623482004065, 4491.685582009228, 4497.730136191773, 4500.797464114123, 9720.611175552898, 9729.65946191894, 9739.513024348755, 9740.659076932274, 9750.0, 4962.255661650781, 4962.851114466572, 4966.925496117489, 4968.403791545038, 4972.453030166679, 4496.797644106023, 4516.254817955067, 4516.593506584423, 4523.163214805271, 4524.819007239674, 3963.5441924178513, 4022.0950286185375, 4037.8788636340955, 4047.2714911316248, 4074.8370065197655, 1159.2175281684829, 1226.6442731607913, 1254.4480428611382, 1311.9212847229005, 1319.736052789446, 1111.4942701070993, 1112.3159257056852, 1112.7051331397186, 1267.1193520503346, 1352.2562590575144, 7758.922410775933, 7862.8427431451055, 7938.483998540077, 7951.0, 7966.522008679498, 1145.828125781123, 1185.0874826383636, 1207.1127721124967, 1209.2019267283727, 1218.3116539155349, 6149.446549810538, 6181.752729890754, 6215.409536094064, 6216.347283535254, 6230.252369715663, 9721.319507634398, 9954.651587194414, 10065.295429319878, 10097.24270679702, 10100.343477673927, 9754.341761900494, 9816.214702823758, 9873.605055797687, 9906.10845023937, 9964.701058968243, 7788.571628560484, 7874.72438464651, 7915.129335773176, 7976.641051152712, 7977.401694872908, 7583.127940286938, 7681.7695469136015, 7722.38220942312, 7743.4966727162555, 7751.961240193763, 8723.302135828992, 8887.37788354809, 8975.50634715097, 9015.729528114167, 9021.128590561286, 8955.865662015205, 9089.636414543344, 9192.17270445663, 9220.907790922272, 9291.256699464162, 7323.523970942085, 7387.963060184665, 7402.925970740223, 7410.407167426485, 7411.0736157980255, 7909.960450197712, 7912.4856884302335, 7938.3252423542335, 7951.284384405431, 8148.592570371339, 6559.114519539992, 7436.070491188601, 7490.213527579525, 7531.096268447822, 7707.11368192665, 6828.9658551706925, 7261.164966028974, 7282.380997615051, 7610.733624323122, 7650.043744531934, 7502.549847009197, 7507.211742766931, 7520.548767073993, 7526.172121066569, 7540.547567145989, 6986.54587451814, 7004.299570042955, 7039.1553013638695, 7052.612106333996, 7060.752873649398, 6917.481188910751, 6977.546459480118, 6992.650367481708, 6996.720131194696, 6999.055127557918], "unit": "ms", "name": "mootools.html", "value": 4769.645305431386}, {"lowerIsBetter": false, "replicates": [344.5864962045546, 344.7328320551571, 345.65089259847554, 350.89293279702537, 352.17766515187037, 6082.513398928087, 6131.294901086377, 6160.537959653027, 6189.226346706661, 6209.0, 5788.5658575606785, 5937.2578427696535, 5994.07091900756, 6000.129981152731, 6080.422359875804, 4651.651126165534, 4657.790399432025, 4677.859664210062, 4679.555442232982, 4693.8357157499495, 4501.909961800762, 4684.227102528096, 4688.671792974493, 4696.43642762869, 4707.529247075299, 4562.064776720765, 4567.817287308504, 4655.720656760605, 4660.510646382115, 4669.53304669532, 4659.580637742602, 4661.160991021615, 4666.859994200146, 4670.906581868344, 4672.3692301539195, 4125.938110928339, 4141.544430112685, 4145.647619952308, 4146.730462519957, 4152.647025002879, 5680.630759000693, 5787.768489260425, 5792.189093526909, 5802.100674395433, 5805.535557155417, 5417.079096553595, 5456.8090116846115, 5459.645123067027, 5472.2338872557875, 5473.01485732568, 6466.482681385525, 6478.514111441614, 6488.67556622167, 6492.480601551864, 6498.480121590262, 4580.862574122782, 4597.37935378723, 4599.149157405857, 4600.401947746805, 4605.700629459075, 6609.471242300652, 6664.500162487784, 6747.245716113796, 6750.864982700318, 6759.019942108416, 4718.905621887612, 4721.787519561628, 4722.315264286659, 4723.905521889612, 4723.929141062887, 4779.641526885497, 4780.880477988008, 4781.139394908881, 4782.234842425195, 4785.617150627942, 5457.645253058538, 5459.426760190202, 5467.863303417367, 5473.124300111963, 5473.261109750212, 6314.526410519229, 6456.838579035561, 6479.935200648028, 6495.642739649365, 6536.084948107269, 1660.7425848993425, 1663.9584010399594, 1665.991670041642, 1667.0664427920403, 1668.457751230855, 1133.7052366384798, 1139.0887290167832, 1146.3981409759776, 1149.1840793037038, 1169.2341516306833, 6382.936170638234, 6387.041943708481, 6389.105525226472, 6396.968015159894, 6400.0, 6476.417122459001, 6718.8320291993095, 6722.529422940347, 6734.831629209309, 6738.35985581369, 6245.219347581552, 6310.43206111443, 6416.615003099829, 6426.196725409324, 6435.195600549931, 3615.457681347819, 3649.9817500912327, 3658.6707196352454, 3660.0666829958723, 3662.7252956028406, 6815.182178138655, 6978.302169782981, 6979.8604027919155, 6989.231184569693, 6992.825179370455, 6937.340952609494, 6941.236463989058, 6956.617386043817, 6965.338292862271, 6967.512274140761, 6984.196817365966, 6984.720611175598, 6993.860122797516, 6997.160340759141, 6998.720051197997, 6646.368594983469, 6773.864522709617, 6784.525083244125, 6787.524873258824, 6789.2192397872905, 6616.239132499824, 6659.766908158192, 6664.033715111379, 6674.632895190811, 6679.432248258952, 6963.1644202696, 6965.965170174117, 6974.895376569254, 6979.720811167496, 6980.7905762827195, 4485.730856148511, 4751.477337492804, 4771.093492236464, 4771.212749896228, 4772.880677983078, 6749.696263668048, 6754.189497260164, 6755.86488270222, 6757.628330441873, 6758.932410676027, 6551.279359270381, 6554.63949482783, 6555.704993275219, 6558.049082883051, 6576.177977752781, 6386.393292637192, 6485.643289619116, 6539.0, 6543.607383557001, 6576.967115164393, 6484.675766211576, 6488.837779055561, 6493.350664933469, 6505.186851643544, 6508.60948343101, 6600.8349791255605, 6612.173478315211, 6618.768343107968, 6619.834504137435, 6632.137822083098, 6316.463100636497, 6468.611883287018, 6468.708908099241, 6470.0, 6494.09082728409], "unit": "ms", "name": "prototype.html", "value": 4940.046636114644}, {"lowerIsBetter": false, "replicates": [947.2564037230771, 948.1892981500816, 948.3124734567438, 950.6910254167396, 957.2004631293167, 14318.284085795707, 14662.853371466283, 14664.41342346305, 14670.119792812438, 14690.926545367285, 13339.399727012284, 13581.0, 14198.574042778733, 14379.92810035951, 14410.495632652859, 732.5348403763621, 738.3797610007592, 861.0442408926102, 872.6029656506274, 873.0396563779855, 861.0657436681208, 863.7667829685981, 871.3247233394106, 871.5859966515918, 872.4242000279817, 871.8299931513358, 897.7531178925782, 898.420518765396, 900.4012331799346, 905.4883990545321, 872.2193636695154, 891.6567121658144, 894.6689724801865, 895.4895709445618, 895.5925054100369, 649.818050945736, 657.2934095846983, 662.6421732264571, 675.7702381190419, 676.3034074902858, 14492.34784434703, 14586.197759123244, 14599.635009124751, 14618.0, 14621.853781462156, 13171.407286672124, 13416.731665366735, 13451.32743362828, 13620.0, 13734.313284335843, 10651.627193048284, 10666.78666426667, 10863.891361086446, 10960.56157753689, 11173.0, 3938.0548668319684, 3971.483707118085, 4001.779902105383, 4009.1329664194022, 4039.3738970459626, 47761.52238477606, 47922.76038619819, 48014.0, 48207.75896120497, 48224.27663585049, 10103.24225683062, 10644.13749051867, 10872.293300935415, 10899.564017439372, 10955.945220273848, 19397.0, 19685.901570492057, 19692.212311507665, 19696.40910772679, 19721.506962326057, 7797.376209903194, 7875.921240787518, 7893.881591776128, 8042.638081286356, 8059.919400806034, 4557.954420455753, 4731.195696731564, 4769.451513075971, 4769.904601907942, 4981.875453113701, 3284.8357582121275, 3317.303366293057, 3319.0706602151436, 3320.1367644412626, 3321.6512266212185, 565.6436445039681, 578.0231408918913, 581.5231510161711, 582.3826743651742, 588.3733823477983, 650.4081286029785, 659.2221179008816, 659.4691273524859, 665.3280187011154, 701.0745815523562, 7823.569703666353, 8101.675932962616, 8161.306288965505, 8282.006159260807, 8338.499690018618, 569.8091139468324, 576.7635269539469, 624.7219987105785, 631.3686313686313, 632.6077831744348, 4042.211768705133, 4078.857239996586, 4107.958920410758, 4119.320312148522, 4155.370409837275, 57727.711361442925, 58854.41145588575, 59605.403945960854, 59809.40190598038, 59860.70069649624, 51944.74027629838, 52158.0, 52171.21743173855, 52256.38718064081, 52418.475815241356, 47304.290435643496, 47903.5209647899, 48577.27134092992, 48801.755991220525, 49261.261081083816, 7970.721024764105, 7988.680452781824, 8148.796280093045, 8160.0, 8233.629486672995, 38518.65184718634, 38776.41835372528, 39503.2099358017, 39593.20813583655, 40174.1965160701, 46071.76964115158, 46090.0, 46193.307100394195, 47278.76360618175, 48240.5175948236, 11160.33038017689, 11200.551977920792, 11646.301221926711, 11737.295762254293, 11791.646250612495, 12685.302308373128, 13091.55065690695, 13094.738105238033, 13095.148815326973, 13325.866741332462, 10897.400642964712, 10922.504828243598, 11023.338599684044, 11136.33182009082, 11616.88383116158, 11022.724431889266, 11434.256773309708, 11490.080793536665, 11774.293542387484, 12057.336846473529, 10166.542505587118, 10389.220808439246, 10544.57821687124, 10640.255182137176, 10659.307145035547, 10350.844737328796, 10453.47732613351, 10540.789184216119, 10597.2581919268, 11198.0, 9596.520173991412, 9730.75673108178, 9768.120869121813, 9796.755081123029, 9815.165710914367], "unit": "ms", "name": "yui.html", "value": 6581.407031105777}], "name": "dromaeo_css", "value": 7402.494466758742}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 110.0, 110.0, 100.0, 112.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [152.0, 121.0, 149.0, 155.0, 124.0, 149.0, 146.0, 122.0, 169.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 159.0, 161.0, 162.0, 160.0, 158.0, 160.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 74.0, 151.0, 74.0, 73.0, 71.0, 71.0, 154.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 92.0, 93.0, 92.0, 145.0, 90.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 98.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [76.0, 86.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 78.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [128.0, 115.0, 113.0, 110.0, 117.0, 121.0, 118.0, 112.0, 119.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [131.0, 142.0, 141.0, 140.0, 142.0, 129.0, 132.0, 142.0, 139.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 66.0, 64.0, 64.0, 62.0, 63.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1472.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.14970453053184], "unit": "score", "name": "Richards", "value": 215.0597840000001}, {"lowerIsBetter": false, "replicates": [164.85328058028355], "unit": "score", "name": "DeltaBlue", "value": 401.0717880000001}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1002.0040080160321], "unit": "score", "name": "RayTrace", "value": 738.509022}, {"lowerIsBetter": false, "replicates": [542.0054200542005], "unit": "score", "name": "Earley", "value": 1229.624235}, {"lowerIsBetter": false, "replicates": [10600.0], "unit": "score", "name": "Boyer", "value": 62.873867924528355}, {"lowerIsBetter": false, "replicates": [24926.829268292684], "unit": "score", "name": "RegExp", "value": 36.54636497064577}, {"lowerIsBetter": false, "replicates": [513.8603696098562], "unit": "score", "name": "Splay", "value": 158.5858821178821}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23195.12649231514}]} 10:34:52 INFO - RETURN: dromaeo_css: 7402.50 10:34:52 INFO - RETURN: kraken: 1472.40 10:34:52 INFO - RETURN: v8_7: 23195.13 10:34:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23195.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7402.50"}}} 10:34:52 INFO - Return code: 0 10:34:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:34:52 INFO - # TBPL SUCCESS # 10:34:52 INFO - Running post-action listener: _resource_record_post_action 10:34:52 INFO - Running post-run listener: _resource_record_post_run 10:34:53 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 510296064; Read time: 0; Write time: 447868 10:34:53 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 246341632; Read time: 0; Write time: 307036 10:34:53 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 263356416; Read time: 0; Write time: 140832 10:34:53 INFO - Running post-run listener: _upload_blobber_files 10:34:53 INFO - Blob upload gear active. 10:34:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:34:53 INFO - Copying logs to upload dir... 10:34:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.407222 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-29 10:34:53.701732) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-29 10:34:53.705210) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009911 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454082446/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-29 10:34:53.755977) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:34:53.756337) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1454089359.965967-163627103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 10:34:53.808144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 10:34:53.808531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 10:34:53.808822) ========= ========= Total master_lag: 0.62 =========