builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1454580600.72 results: success (0) buildid: 20160203234125 builduid: d917ddbf6baa4283bd8152fdca655a67 revision: 70033723c1df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.721416) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.721851) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.722135) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004171 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.739006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.739289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.752167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.752468) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.998288) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.998612) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.999066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:00.999350) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-04 02:10:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-02-04 02:10:01 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.106162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.106481) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020081 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.156261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.156680) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 70033723c1df --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 70033723c1df --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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-04 02:10:01,876 Setting DEBUG logging. 2016-02-04 02:10:01,876 attempt 1/10 2016-02-04 02:10:01,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/70033723c1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 02:10:02,137 unpacking tar archive at: mozilla-beta-70033723c1df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.715845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.716220) ========= echo 70033723c1df in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'70033723c1df'] 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 70033723c1df program finished with exit code 0 elapsedTime=0.004077 script_repo_revision: '70033723c1df' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.766520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.766902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 02:10:01.776798) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-04 02:10:01.777232) ========= /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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:02 INFO - MultiFileLogger online at 20160204 02:10:02 in /builds/slave/test-pgo 02:10:02 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 02:10:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:10:02 INFO - {'append_to_log': False, 02:10:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:10:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:10:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:10:02 INFO - 'branch': 'Mozilla-Beta', 02:10:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:02 INFO - 'config_files': ('talos/linux_config.py',), 02:10:02 INFO - 'default_actions': ('clobber', 02:10:02 INFO - 'read-buildbot-config', 02:10:02 INFO - 'download-and-extract', 02:10:02 INFO - 'populate-webroot', 02:10:02 INFO - 'create-virtualenv', 02:10:02 INFO - 'install', 02:10:02 INFO - 'run-tests'), 02:10:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:02 INFO - 'download_minidump_stackwalk': True, 02:10:02 INFO - 'download_symbols': 'ondemand', 02:10:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:02 INFO - 'installer_path': 'installer.exe', 02:10:02 INFO - 'log_level': 'info', 02:10:02 INFO - 'log_name': 'talos', 02:10:02 INFO - 'log_to_console': True, 02:10:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:02 INFO - 'opt_config_files': (), 02:10:02 INFO - 'pip_index': False, 02:10:02 INFO - 'sps_profile': False, 02:10:02 INFO - 'sps_profile_interval': 0, 02:10:02 INFO - 'suite': 'dromaeojs', 02:10:02 INFO - 'system_bits': '32', 02:10:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:02 INFO - 'title': 'talos-linux64-ix-001', 02:10:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:02 INFO - 'use_talos_json': True, 02:10:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:10:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:02 INFO - 'work_dir': 'build'} 02:10:02 INFO - ##### 02:10:02 INFO - ##### Running clobber step. 02:10:02 INFO - ##### 02:10:02 INFO - Running pre-action listener: _resource_record_pre_action 02:10:02 INFO - Running main action method: clobber 02:10:02 INFO - rmtree: /builds/slave/test-pgo/build 02:10:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:10:03 INFO - Running post-action listener: _resource_record_post_action 02:10:03 INFO - ##### 02:10:03 INFO - ##### Running read-buildbot-config step. 02:10:03 INFO - ##### 02:10:03 INFO - Running pre-action listener: _resource_record_pre_action 02:10:03 INFO - Running main action method: read_buildbot_config 02:10:03 INFO - Using buildbot properties: 02:10:03 INFO - { 02:10:03 INFO - "properties": { 02:10:03 INFO - "buildnumber": 103, 02:10:03 INFO - "product": "firefox", 02:10:03 INFO - "script_repo_revision": "production", 02:10:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:10:03 INFO - "repository": "", 02:10:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 02:10:03 INFO - "buildid": "20160203234125", 02:10:03 INFO - "slavename": "talos-linux64-ix-001", 02:10:03 INFO - "pgo_build": "True", 02:10:03 INFO - "basedir": "/builds/slave/test-pgo", 02:10:03 INFO - "project": "", 02:10:03 INFO - "platform": "ubuntu64_hw", 02:10:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:10:03 INFO - "slavebuilddir": "test", 02:10:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:10:03 INFO - "branch": "mozilla-beta", 02:10:03 INFO - "repo_path": "releases/mozilla-beta", 02:10:03 INFO - "stage_platform": "linux64-pgo", 02:10:03 INFO - "builduid": "d917ddbf6baa4283bd8152fdca655a67", 02:10:03 INFO - "revision": "70033723c1df" 02:10:03 INFO - }, 02:10:03 INFO - "sourcestamp": { 02:10:03 INFO - "repository": "", 02:10:03 INFO - "hasPatch": false, 02:10:03 INFO - "project": "", 02:10:03 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 02:10:03 INFO - "changes": [ 02:10:03 INFO - { 02:10:03 INFO - "category": null, 02:10:03 INFO - "files": [ 02:10:03 INFO - { 02:10:03 INFO - "url": null, 02:10:03 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2" 02:10:03 INFO - } 02:10:03 INFO - ], 02:10:03 INFO - "repository": "", 02:10:03 INFO - "rev": "70033723c1df", 02:10:03 INFO - "who": "sendchange", 02:10:03 INFO - "when": 1454580573, 02:10:03 INFO - "number": 7561681, 02:10:03 INFO - "comments": "Bug 1204174 - Reduce test iterations to reduce intermittent timeouts. r=vp, a=test-only", 02:10:03 INFO - "project": "", 02:10:03 INFO - "at": "Thu 04 Feb 2016 02:09:33", 02:10:03 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 02:10:03 INFO - "revlink": "", 02:10:03 INFO - "properties": [ 02:10:03 INFO - [ 02:10:03 INFO - "buildid", 02:10:03 INFO - "20160203234125", 02:10:03 INFO - "Change" 02:10:03 INFO - ], 02:10:03 INFO - [ 02:10:03 INFO - "builduid", 02:10:03 INFO - "d917ddbf6baa4283bd8152fdca655a67", 02:10:03 INFO - "Change" 02:10:03 INFO - ], 02:10:03 INFO - [ 02:10:03 INFO - "pgo_build", 02:10:03 INFO - "True", 02:10:03 INFO - "Change" 02:10:03 INFO - ] 02:10:03 INFO - ], 02:10:03 INFO - "revision": "70033723c1df" 02:10:03 INFO - } 02:10:03 INFO - ], 02:10:03 INFO - "revision": "70033723c1df" 02:10:03 INFO - } 02:10:03 INFO - } 02:10:03 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2. 02:10:03 INFO - Running post-action listener: _resource_record_post_action 02:10:03 INFO - ##### 02:10:03 INFO - ##### Running download-and-extract step. 02:10:03 INFO - ##### 02:10:03 INFO - Running pre-action listener: _resource_record_pre_action 02:10:03 INFO - Running main action method: download_and_extract 02:10:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/test_packages.json 02:10:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:10:03 INFO - Downloaded 1270 bytes. 02:10:03 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:10:03 INFO - Using the following test package requirements: 02:10:03 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 02:10:03 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:03 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'jsshell-linux-x86_64.zip'], 02:10:03 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:03 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 02:10:03 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 02:10:03 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 02:10:03 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:03 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 02:10:03 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 02:10:03 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:03 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.common.tests.zip 02:10:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:04 INFO - Downloaded 21581657 bytes. 02:10:04 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 02:10:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 02:10:04 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 02:10:05 INFO - Return code: 0 02:10:05 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 02:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.common.tests.zip 02:10:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:05 INFO - Downloaded 21581657 bytes. 02:10:05 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 02:10:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 02:10:05 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 02:10:07 INFO - Return code: 0 02:10: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')]} 02:10:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 02:10:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:09 INFO - Downloaded 11132038 bytes. 02:10:09 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 02:10:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 02:10:09 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 02:10:09 INFO - Return code: 0 02:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2 02:10:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/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 02:10:10 INFO - Downloaded 57945017 bytes. 02:10:10 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2 02:10:10 INFO - mkdir: /builds/slave/test-pgo/properties 02:10:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:10:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:10:10 INFO - Contents: 02:10:10 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2 02:10:10 INFO - Running post-action listener: _resource_record_post_action 02:10:10 INFO - Running post-action listener: set_extra_try_arguments 02:10:10 INFO - ##### 02:10:10 INFO - ##### Running populate-webroot step. 02:10:10 INFO - ##### 02:10:10 INFO - Running pre-action listener: _resource_record_pre_action 02:10:10 INFO - Running main action method: populate_webroot 02:10:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:10 INFO - '--tppagecycles', 02:10:10 INFO - '7'], 02:10:10 INFO - 'tests': ['tsvgm']}}, 02:10:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:10:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:10:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:10:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['damp', 'tps']}, 02:10:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['damp', 'tps']}, 02:10:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:10:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:10 INFO - 'other': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'other_l64': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'other_nol64': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore']}, 02:10:10 INFO - 'svgr': {'tests': ['tsvgx', 02:10:10 INFO - 'tsvgr_opacity', 02:10:10 INFO - 'tart', 02:10:10 INFO - 'tscrollx', 02:10:10 INFO - 'cart']}, 02:10:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['tsvgx', 02:10:10 INFO - 'tsvgr_opacity', 02:10:10 INFO - 'tart', 02:10:10 INFO - 'tscrollx', 02:10:10 INFO - 'cart']}, 02:10:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['tp5o']}, 02:10:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--e10s'], 02:10:10 INFO - 'tests': ['tp5o']}, 02:10:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--xperf_path', 02:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:10 INFO - 'tests': ['tp5n']}, 02:10:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--e10s', 02:10:10 INFO - '--xperf_path', 02:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:10 INFO - 'tests': ['tp5n']}}, 02:10:10 INFO - 'talos.zip': {'path': '', 02:10:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:10 INFO - Running post-action listener: _resource_record_post_action 02:10:10 INFO - ##### 02:10:10 INFO - ##### Running create-virtualenv step. 02:10:10 INFO - ##### 02:10:10 INFO - Running pre-action listener: _resource_record_pre_action 02:10:10 INFO - Running main action method: create_virtualenv 02:10:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:10:10 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 02:10:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:10:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:10 INFO - Using real prefix '/usr' 02:10:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:10:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:13 INFO - Installing pip.................done. 02:10:13 INFO - Return code: 0 02:10:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:13 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 02:10:13 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 02:10:13 INFO - Using env: {'DISPLAY': ':0', 02:10:13 INFO - 'HOME': '/home/cltbld', 02:10:13 INFO - 'LANG': 'en_US.UTF-8', 02:10:13 INFO - 'LANGUAGE': 'en_US:en', 02:10:13 INFO - 'LOGNAME': 'cltbld', 02:10:13 INFO - 'MAIL': '/var/mail/cltbld', 02:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:13 INFO - 'MOZ_NO_REMOTE': '1', 02:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:13 INFO - 'NO_EM_RESTART': '1', 02:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:13 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:13 INFO - 'SHELL': '/bin/bash', 02:10:13 INFO - 'SHLVL': '1', 02:10:13 INFO - 'TERM': 'linux', 02:10:13 INFO - 'TMOUT': '86400', 02:10:13 INFO - 'USER': 'cltbld', 02:10:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:13 INFO - '_': '/tools/buildbot/bin/python'} 02:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:13 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 02:10:13 INFO - Cleaning up... 02:10:13 INFO - Return code: 0 02:10:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:13 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 02:10:13 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 02:10:13 INFO - Using env: {'DISPLAY': ':0', 02:10:13 INFO - 'HOME': '/home/cltbld', 02:10:13 INFO - 'LANG': 'en_US.UTF-8', 02:10:13 INFO - 'LANGUAGE': 'en_US:en', 02:10:13 INFO - 'LOGNAME': 'cltbld', 02:10:13 INFO - 'MAIL': '/var/mail/cltbld', 02:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:13 INFO - 'MOZ_NO_REMOTE': '1', 02:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:13 INFO - 'NO_EM_RESTART': '1', 02:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:13 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:13 INFO - 'SHELL': '/bin/bash', 02:10:13 INFO - 'SHLVL': '1', 02:10:13 INFO - 'TERM': 'linux', 02:10:13 INFO - 'TMOUT': '86400', 02:10:13 INFO - 'USER': 'cltbld', 02:10:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:13 INFO - '_': '/tools/buildbot/bin/python'} 02:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:13 INFO - Downloading/unpacking psutil>=0.7.1 02:10:13 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 02:10:13 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 02:10:13 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 02:10:13 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 02:10:13 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 02:10:13 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 02:10:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:15 INFO - Installing collected packages: psutil 02:10:15 INFO - Running setup.py install for psutil 02:10:15 INFO - building 'psutil._psutil_linux' extension 02:10:15 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 02:10:15 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 02:10:15 INFO - building 'psutil._psutil_posix' extension 02:10:15 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 02:10:15 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 02:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:15 INFO - Successfully installed psutil 02:10:15 INFO - Cleaning up... 02:10:15 INFO - Return code: 0 02:10:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:10: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')]} 02:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:15 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:15 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 02:10:15 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 02:10:15 INFO - Using env: {'DISPLAY': ':0', 02:10:15 INFO - 'HOME': '/home/cltbld', 02:10:15 INFO - 'LANG': 'en_US.UTF-8', 02:10:15 INFO - 'LANGUAGE': 'en_US:en', 02:10:15 INFO - 'LOGNAME': 'cltbld', 02:10:15 INFO - 'MAIL': '/var/mail/cltbld', 02:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:15 INFO - 'MOZ_NO_REMOTE': '1', 02:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:15 INFO - 'NO_EM_RESTART': '1', 02:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:15 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:15 INFO - 'SHELL': '/bin/bash', 02:10:15 INFO - 'SHLVL': '1', 02:10:15 INFO - 'TERM': 'linux', 02:10:15 INFO - 'TMOUT': '86400', 02:10:15 INFO - 'USER': 'cltbld', 02:10:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:15 INFO - '_': '/tools/buildbot/bin/python'} 02:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:10:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:10:18 INFO - Installing collected packages: mozsystemmonitor 02:10:18 INFO - Running setup.py install for mozsystemmonitor 02:10:18 INFO - Successfully installed mozsystemmonitor 02:10:18 INFO - Cleaning up... 02:10:18 INFO - Return code: 0 02:10:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:10:18 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')]} 02:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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')]} 02:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:18 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 02:10:18 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 02:10:18 INFO - Using env: {'DISPLAY': ':0', 02:10:18 INFO - 'HOME': '/home/cltbld', 02:10:18 INFO - 'LANG': 'en_US.UTF-8', 02:10:18 INFO - 'LANGUAGE': 'en_US:en', 02:10:18 INFO - 'LOGNAME': 'cltbld', 02:10:18 INFO - 'MAIL': '/var/mail/cltbld', 02:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:18 INFO - 'MOZ_NO_REMOTE': '1', 02:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:18 INFO - 'NO_EM_RESTART': '1', 02:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:18 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:18 INFO - 'SHELL': '/bin/bash', 02:10:18 INFO - 'SHLVL': '1', 02:10:18 INFO - 'TERM': 'linux', 02:10:18 INFO - 'TMOUT': '86400', 02:10:18 INFO - 'USER': 'cltbld', 02:10:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:18 INFO - '_': '/tools/buildbot/bin/python'} 02:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:10:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10: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 02:10:20 INFO - Downloading docopt-0.6.1.tar.gz 02:10:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:20 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:20 INFO - Running setup.py install for blobuploader 02:10:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:10:21 INFO - Running setup.py install for requests 02:10:21 INFO - Running setup.py install for docopt 02:10:21 INFO - Successfully installed blobuploader requests docopt 02:10:21 INFO - Cleaning up... 02:10:21 INFO - Return code: 0 02:10:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:10:21 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')]} 02:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:21 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')]} 02:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:21 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:21 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 02:10:21 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 02:10:21 INFO - Using env: {'DISPLAY': ':0', 02:10:21 INFO - 'HOME': '/home/cltbld', 02:10:21 INFO - 'LANG': 'en_US.UTF-8', 02:10:21 INFO - 'LANGUAGE': 'en_US:en', 02:10:21 INFO - 'LOGNAME': 'cltbld', 02:10:21 INFO - 'MAIL': '/var/mail/cltbld', 02:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:21 INFO - 'MOZ_NO_REMOTE': '1', 02:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:21 INFO - 'NO_EM_RESTART': '1', 02:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:21 INFO - 'SHELL': '/bin/bash', 02:10:21 INFO - 'SHLVL': '1', 02:10:21 INFO - 'TERM': 'linux', 02:10:21 INFO - 'TMOUT': '86400', 02:10:21 INFO - 'USER': 'cltbld', 02:10:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:21 INFO - '_': '/tools/buildbot/bin/python'} 02:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:10:21 INFO - Running setup.py (path:/tmp/pip-2AJmyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:10:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:10:21 INFO - Running setup.py (path:/tmp/pip-Od7QHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:10:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:10:21 INFO - Running setup.py (path:/tmp/pip-Ppha8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:10:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:10:21 INFO - Running setup.py (path:/tmp/pip-97Qk9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:10:22 INFO - Running setup.py (path:/tmp/pip-Liihry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:10:22 INFO - Running setup.py (path:/tmp/pip-ew7z0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:10:22 INFO - Running setup.py (path:/tmp/pip-Pw5AqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:10:22 INFO - Running setup.py (path:/tmp/pip-brh_VO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:10:22 INFO - Running setup.py (path:/tmp/pip-pnZZ6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:10:22 INFO - Running setup.py (path:/tmp/pip-uhAsUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:10:22 INFO - Running setup.py (path:/tmp/pip-VUy0ai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:10:22 INFO - Running setup.py (path:/tmp/pip-HY4yY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:10:22 INFO - Running setup.py (path:/tmp/pip-n_WNHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:10:22 INFO - Running setup.py (path:/tmp/pip-tI1fvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:10:22 INFO - Running setup.py (path:/tmp/pip-PQE1WL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:10:22 INFO - Running setup.py (path:/tmp/pip-5XAgHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:10:22 INFO - Running setup.py (path:/tmp/pip-5B0gUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:10:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:22 INFO - Running setup.py install for manifestparser 02:10:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Running setup.py install for mozcrash 02:10:23 INFO - Running setup.py install for mozdebug 02:10:23 INFO - Running setup.py install for mozdevice 02:10:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Running setup.py install for mozfile 02:10:23 INFO - Running setup.py install for mozhttpd 02:10:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Running setup.py install for mozinfo 02:10:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Running setup.py install for mozInstall 02:10:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:10:23 INFO - Running setup.py install for mozleak 02:10:23 INFO - Running setup.py install for mozlog 02:10:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Running setup.py install for moznetwork 02:10:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Running setup.py install for mozprocess 02:10:24 INFO - Running setup.py install for mozprofile 02:10:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Running setup.py install for mozrunner 02:10:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Running setup.py install for mozscreenshot 02:10:24 INFO - Running setup.py install for moztest 02:10:24 INFO - Running setup.py install for mozversion 02:10:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:10:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:24 INFO - Cleaning up... 02:10:24 INFO - Return code: 0 02:10:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:10:24 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')]} 02:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 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')]} 02:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:24 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 02:10:24 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 02:10:24 INFO - Using env: {'DISPLAY': ':0', 02:10:24 INFO - 'HOME': '/home/cltbld', 02:10:24 INFO - 'LANG': 'en_US.UTF-8', 02:10:24 INFO - 'LANGUAGE': 'en_US:en', 02:10:24 INFO - 'LOGNAME': 'cltbld', 02:10:24 INFO - 'MAIL': '/var/mail/cltbld', 02:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:24 INFO - 'MOZ_NO_REMOTE': '1', 02:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:24 INFO - 'NO_EM_RESTART': '1', 02:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:24 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:24 INFO - 'SHELL': '/bin/bash', 02:10:24 INFO - 'SHLVL': '1', 02:10:24 INFO - 'TERM': 'linux', 02:10:24 INFO - 'TMOUT': '86400', 02:10:24 INFO - 'USER': 'cltbld', 02:10:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:24 INFO - '_': '/tools/buildbot/bin/python'} 02:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:10:24 INFO - Running setup.py (path:/tmp/pip-tKV45l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:10:25 INFO - Running setup.py (path:/tmp/pip-2WX8j4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:10:25 INFO - Running setup.py (path:/tmp/pip-xTOvKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:10:25 INFO - Running setup.py (path:/tmp/pip-QTfeFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:10:25 INFO - Running setup.py (path:/tmp/pip-wX5XaT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:10:25 INFO - Running setup.py (path:/tmp/pip-p_212a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:10:25 INFO - Running setup.py (path:/tmp/pip-HldJVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:10:25 INFO - Running setup.py (path:/tmp/pip-yD2dbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:10:25 INFO - Running setup.py (path:/tmp/pip-qvpX1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:10:25 INFO - Running setup.py (path:/tmp/pip-EsfPMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:10:25 INFO - Running setup.py (path:/tmp/pip-sVTgAx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:10:25 INFO - Running setup.py (path:/tmp/pip-YQGY77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:10:25 INFO - Running setup.py (path:/tmp/pip-NuiAGf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:10:25 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)) 02:10:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:10:25 INFO - Running setup.py (path:/tmp/pip-aZGi66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Running setup.py (path:/tmp/pip-tI2flL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 02:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:10:26 INFO - Running setup.py (path:/tmp/pip-9Pw0gL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:10:26 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)) 02:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:10:26 INFO - Running setup.py (path:/tmp/pip-DW_nJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:10:26 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)) 02:10:26 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)) 02:10:26 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)) 02:10:26 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)) 02:10:26 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)) 02:10:26 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)) 02:10:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:26 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 02:10:27 INFO - Downloading blessings-1.6.tar.gz 02:10:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:28 INFO - Installing collected packages: blessings 02:10:28 INFO - Running setup.py install for blessings 02:10:28 INFO - Successfully installed blessings 02:10:28 INFO - Cleaning up... 02:10:28 INFO - Return code: 0 02:10:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:10:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:10:28 INFO - Reading from file tmpfile_stdout 02:10:28 INFO - Current package versions: 02:10:28 INFO - argparse == 1.2.1 02:10:28 INFO - blessings == 1.6 02:10:28 INFO - blobuploader == 1.2.4 02:10:28 INFO - docopt == 0.6.1 02:10:28 INFO - manifestparser == 1.1 02:10:28 INFO - mozInstall == 1.12 02:10:28 INFO - mozcrash == 0.16 02:10:28 INFO - mozdebug == 0.1 02:10:28 INFO - mozdevice == 0.47 02:10:28 INFO - mozfile == 1.2 02:10:28 INFO - mozhttpd == 0.7 02:10:28 INFO - mozinfo == 0.9 02:10:28 INFO - mozleak == 0.1 02:10:28 INFO - mozlog == 3.1 02:10:28 INFO - moznetwork == 0.27 02:10:28 INFO - mozprocess == 0.22 02:10:28 INFO - mozprofile == 0.27 02:10:28 INFO - mozrunner == 6.11 02:10:28 INFO - mozscreenshot == 0.1 02:10:28 INFO - mozsystemmonitor == 0.0 02:10:28 INFO - moztest == 0.7 02:10:28 INFO - mozversion == 1.4 02:10:28 INFO - psutil == 3.1.1 02:10:28 INFO - requests == 1.2.3 02:10:28 INFO - wsgiref == 0.1.2 02:10:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:10:28 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')]} 02:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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')]} 02:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:28 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 02:10:28 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 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 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)) 02:10:28 INFO - Cleaning up... 02:10:28 INFO - Return code: 0 02:10:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:10:28 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')]} 02:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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')]} 02:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:28 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 02:10:28 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 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 INFO - Downloading/unpacking jsonschema 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:28 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 02:10:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:30 INFO - Downloading/unpacking functools32 (from jsonschema) 02:10:30 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 02:10:30 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 02:10:30 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 02:10:30 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 02:10:30 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 02:10:30 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 02:10:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:30 INFO - warning: no files found matching '*.txt' 02:10:30 INFO - no previously-included directories found matching 'build' 02:10:30 INFO - no previously-included directories found matching 'dist' 02:10:30 INFO - no previously-included directories found matching '.git*' 02:10:30 INFO - Installing collected packages: jsonschema, functools32 02:10:30 INFO - Running setup.py install for functools32 02:10:31 INFO - warning: no files found matching '*.txt' 02:10:31 INFO - no previously-included directories found matching 'build' 02:10:31 INFO - no previously-included directories found matching 'dist' 02:10:31 INFO - no previously-included directories found matching '.git*' 02:10:31 INFO - Successfully installed jsonschema functools32 02:10:31 INFO - Cleaning up... 02:10:31 INFO - Return code: 0 02:10:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:10:31 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')]} 02:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:31 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')]} 02:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:31 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 0x7f0f4bb6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, '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': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', '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 02:10:31 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 02:10:31 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 02:10:31 INFO - Using env: {'DISPLAY': ':0', 02:10:31 INFO - 'HOME': '/home/cltbld', 02:10:31 INFO - 'LANG': 'en_US.UTF-8', 02:10:31 INFO - 'LANGUAGE': 'en_US:en', 02:10:31 INFO - 'LOGNAME': 'cltbld', 02:10:31 INFO - 'MAIL': '/var/mail/cltbld', 02:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:31 INFO - 'MOZ_NO_REMOTE': '1', 02:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:31 INFO - 'NO_EM_RESTART': '1', 02:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:31 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:31 INFO - 'SHELL': '/bin/bash', 02:10:31 INFO - 'SHLVL': '1', 02:10:31 INFO - 'TERM': 'linux', 02:10:31 INFO - 'TMOUT': '86400', 02:10:31 INFO - 'USER': 'cltbld', 02:10:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:31 INFO - '_': '/tools/buildbot/bin/python'} 02:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:31 INFO - Downloading/unpacking flake8 02:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:10:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:10:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 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 02:10:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:33 INFO - no previously-included directories found matching 'docs/_build' 02:10:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:10:33 INFO - Running setup.py install for pep8 02:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:10:33 INFO - no previously-included directories found matching 'docs/_build' 02:10:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:10:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:10:34 INFO - Cleaning up... 02:10:34 INFO - Return code: 0 02:10:34 INFO - Running post-action listener: _resource_record_post_action 02:10:34 INFO - Running post-action listener: _start_resource_monitoring 02:10:34 INFO - Starting resource monitoring. 02:10:34 INFO - ##### 02:10:34 INFO - ##### Running install step. 02:10:34 INFO - ##### 02:10:34 INFO - Running pre-action listener: _resource_record_pre_action 02:10:34 INFO - Running main action method: install 02:10:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:10:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:10:34 INFO - Reading from file tmpfile_stdout 02:10:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:10:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:10:34 INFO - Reading from file tmpfile_stdout 02:10:34 INFO - Output received: 02:10:34 INFO - Usage: mozinstall [options] installer 02:10:34 INFO - Options: 02:10:34 INFO - -h, --help show this help message and exit 02:10:34 INFO - -d DEST, --destination=DEST 02:10:34 INFO - Directory to install application into. [default: 02:10:34 INFO - "/builds/slave/test-pgo"] 02:10:34 INFO - --app=APP Application being installed. [default: firefox] 02:10:34 INFO - mkdir: /builds/slave/test-pgo/build/application 02:10:34 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'] 02:10:34 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 02:10:48 INFO - Reading from file tmpfile_stdout 02:10:48 INFO - Output received: 02:10:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:10:48 INFO - Running post-action listener: _resource_record_post_action 02:10:48 INFO - ##### 02:10:48 INFO - ##### Running run-tests step. 02:10:48 INFO - ##### 02:10:48 INFO - Running pre-action listener: _resource_record_pre_action 02:10:48 INFO - Running main action method: run_tests 02:10:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:10:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:10:48 INFO - Python 2.7.3 02:10:48 INFO - Return code: 0 02:10:48 INFO - grabbing minidump binary from tooltool 02:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:10:48 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 0x1963350>, '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 0x1964250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19646e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:10:48 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 02:10:48 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 02:10:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:49 INFO - Return code: 0 02:10:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:10:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:10:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:10:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:10:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:10:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:10:50 INFO - Return code: 0 02:10:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:10:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 02:10:50 INFO - Using env: {'DISPLAY': ':0', 02:10:50 INFO - 'HOME': '/home/cltbld', 02:10:50 INFO - 'LANG': 'en_US.UTF-8', 02:10:50 INFO - 'LANGUAGE': 'en_US:en', 02:10:50 INFO - 'LOGNAME': 'cltbld', 02:10:50 INFO - 'MAIL': '/var/mail/cltbld', 02:10:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:10:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:50 INFO - 'MOZ_NO_REMOTE': '1', 02:10:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:50 INFO - 'NO_EM_RESTART': '1', 02:10:50 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:10:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:10:50 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:10:50 INFO - 'SHELL': '/bin/bash', 02:10:50 INFO - 'SHLVL': '1', 02:10:50 INFO - 'TERM': 'linux', 02:10:50 INFO - 'TMOUT': '86400', 02:10:50 INFO - 'USER': 'cltbld', 02:10:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109', 02:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:50 INFO - '_': '/tools/buildbot/bin/python'} 02:10:50 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 02:10:50 INFO - mozversion INFO | application_buildid: 20160203234125 02:10:50 INFO - mozversion INFO | application_changeset: 70033723c1dfa9c7b559c526f69838f4aed20fc8 02:10:50 INFO - mozversion INFO | application_display_name: Nightly 02:10:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:50 INFO - mozversion INFO | application_name: Firefox 02:10:50 INFO - mozversion INFO | application_remotingname: firefox 02:10:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:10:50 INFO - mozversion INFO | application_vendor: Mozilla 02:10:50 INFO - mozversion INFO | application_version: 45.0 02:10:50 INFO - mozversion INFO | platform_buildid: 20160203234125 02:10:50 INFO - mozversion INFO | platform_changeset: 70033723c1dfa9c7b559c526f69838f4aed20fc8 02:10:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:10:50 INFO - mozversion INFO | platform_version: 45.0 02:10:50 INFO - 2016-02-04 02:10:50,297 DEBUG : using testdate: 1454580650 02:10:50 INFO - 2016-02-04 02:10:50,297 DEBUG : actual date: 1454580650 02:10:50 INFO - 2016-02-04 02:10:50,389 INFO : starting webserver on 'localhost:57433' 02:10:50 INFO - 2016-02-04 02:10:50,390 INFO : Starting test suite talos-linux64-ix-001 02:10:50 INFO - 2016-02-04 02:10:50,390 INFO : Starting test dromaeo_css 02:10:50 INFO - 2016-02-04 02:10:50,390 DEBUG : operating with platform_type : linux_ 02:10:50 INFO - 2016-02-04 02:10:50,391 INFO : Initialising browser for dromaeo_css test... 02:10:50 INFO - 2016-02-04 02:10:50,406 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqgvSai/profile http://localhost:57433/getInfo.html 02:10:54 INFO - 2016-02-04 02:10:54,351 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:10:54 INFO - 2016-02-04 02:10:54,351 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:10:54 INFO - 2016-02-04 02:10:54,351 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:10:54 INFO - 2016-02-04 02:10:54,351 DEBUG : BROWSER_OUTPUT: __metrics 02:10:54 INFO - 2016-02-04 02:10:54,476 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] 02:10:55 INFO - 2016-02-04 02:10:55,176 INFO : Browser initialized. 02:10:55 INFO - 2016-02-04 02:10:55,177 INFO : Running cycle 1/1 for dromaeo_css test... 02:10:55 INFO - 2016-02-04 02:10:55,177 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqgvSai/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:11:07 INFO - 2016-02-04 02:11:07,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 133754880 02:11:07 INFO - 2016-02-04 02:11:07,001 DEBUG : BROWSER_OUTPUT: 02:11:57 INFO - 2016-02-04 02:11:57,691 DEBUG : BROWSER_OUTPUT: 1454580717690 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] 02:14:06 INFO - 2016-02-04 02:14:06,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57433/tests/dromaeo/cssquery-ext.html) 02:14:07 INFO - 2016-02-04 02:14:07,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 241905664 02:14:07 INFO - 2016-02-04 02:14:07,136 DEBUG : BROWSER_OUTPUT: 02:17:09 INFO - 2016-02-04 02:17:09,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-ext.html (next: http://localhost:57433/tests/dromaeo/cssquery-jquery.html) 02:17:09 INFO - 2016-02-04 02:17:09,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 215441408 02:17:09 INFO - 2016-02-04 02:17:09,774 DEBUG : BROWSER_OUTPUT: 02:20:11 INFO - 2016-02-04 02:20:11,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57433/tests/dromaeo/cssquery-mootools.html) 02:20:12 INFO - 2016-02-04 02:20:12,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 215318528 02:20:12 INFO - 2016-02-04 02:20:12,122 DEBUG : BROWSER_OUTPUT: 02:23:13 INFO - 2016-02-04 02:23:13,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57433/tests/dromaeo/cssquery-prototype.html) 02:23:14 INFO - 2016-02-04 02:23:14,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 202797056 02:23:14 INFO - 2016-02-04 02:23:14,426 DEBUG : BROWSER_OUTPUT: 02:26:16 INFO - 2016-02-04 02:26:16,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57433/tests/dromaeo/cssquery-yui.html) 02:26:17 INFO - 2016-02-04 02:26:17,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 200724480 02:26:17 INFO - 2016-02-04 02:26:17,331 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/dromaeo/cssquery-yui.html (next: http://localhost:57433/tests/dromaeo/cssquery-dojo.html) 02:29:19 INFO - 2016-02-04 02:29:19,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 225906688 02:29:19 INFO - 2016-02-04 02:29:19,686 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,686 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:29:19 INFO - 2016-02-04 02:29:19,686 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:29:19 INFO - 2016-02-04 02:29:19,687 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:29:19 INFO - 2016-02-04 02:29:19,687 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:29:19 INFO - 2016-02-04 02:29:19,688 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3306.3222039481907;3347.0460918638178;3348.7655864089525;3358.580177477815;3360.17675669461;5548.528375088117;5577.581681373903;5608.130739735342;5624.3813180550105;5635.464630860072;5568.443155684429;5615.354234263051;5629.043062679344;5631.0708733059;5633.690147041911;4984.601231901439;5064.873378165538;5087.135187018197;5093.821716239932;5154.639175257734;4967.0810899983435;5041.571466425358;5064.860406408547;5071.797128114871;5126.615503837227;5080.77136528857;5084.618653600976;5093.0577843099145;5094.337736094321;5123.641345105844;5073;5085.771140298695;5132.794688212448;5148.099082660538;5157.742112894341;4840.806367745286;4910.901781964377;4934.531219534175;4998.375203099613;5023.196288593807;5348.983693098299;5404.756785944642;5406.107992181285;5419.620626556142;5445.591580631469;5709.4290570942985;6008;6025.879482410327;6028.246469191351;6028.668423236721;5762.510186634141;5902.61632993854;5922.58541902067;5985.221921150222;6005.6997150142315;5555.30558680165;5578.30271216098;5586.413426590231;5596.804111856106;5597.63615365;5946.108083787466;6060.484858786965;6065.2418447694035;6066.4540191382985;6067.24159480065;5813.360530341659;5882.176495290662;5889.882202356014;5890.823275301748;5931.317898441648;5919.141724449931;6027.819165424957;6039.818805435844;6054.878902421927;6058.969705151534;5784.82645520635;5786.305643322744;5912.526997840162;5981.252343457068;6016.789412370546;5941.673207973603;5964.433378829004;5975.163477113208;5976.880462390728;6006.339302676702;4552.590266875931;4585.518520555293;4596.2416201326405;4599.33309670096;4611.262198048296;3974.066094467798;4016.156607112539;4085.8365665373053;4098.344264917659;4141.254574176617;5705.058665320259;5734.885302293931;5742.942570574241;5743.052396354638;5743.2246646703;6037.1246169305205;6067.1202675611785;6068.787592434243;6072.817815465543;6075.453209211192;5469.699166545878;5568;5598.10430331145;5643;5697.4302569742695;5160.612954028463;5201.921971170435;5204.921926171035;5206.114960456732;5218.269442278084;6004.849878752979;6170.413810687977;6171.105189747462;6179.16581261533;6181.134641150243;5892.322382926019;5968.910466342922;6038.3357830637715;6049.606775559574;6078.392160784063;6147.047207682816;6157.84605384869;6157.907631385622;6158.876822463615;6162.044883043135;5617.522510586646;5763.221965034667;5907.822765317047;5913.408659134052;5915.37888521699;5819.214406055128;5904.9704751475965;5909.674967876636;5928.199693041384;5935.881282374415;5755;5779.971100144472;5800.158976948234;5815.185873977731;5857.7949771757785;5599.412061733622;5664.5751568631695;5812.7674893003805;5815.5929084963645;5817.76728930838;5681.0058239808695;5729.197912292199;5737.053386191232;5745.770169193185;5778.653280802997;5914.112883067574;5919.526437884872;5921.348651648229;5924.585279030426;5937.406259374201;5435.782568697208;5460.6177567569885;5696.430356964271;5741.45456181662;5770.596058275881 02:29:19 INFO - 2016-02-04 02:29:19,689 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.2229834320354;608.4645511949485;623.1898531908521;643.1960049937575;653.9444147247484;41782.58217417825;42269;42297.78851105744;42326.78836605813;42460.57539424609;46544.30183547241;47069.52930470694;47088.76455617717;47119.52880471194;47188.76405617967;8165.3059489943425;8261.463004904663;8880.422772519765;9138.77153071172;10230.283880128394;10461.633842815503;10517;10562.471876406187;10568.313059651098;10571.947140264288;10607.363558186495;10666.78666426671;10690.091342235919;10700.625478108268;10703.518341674644;10496.107830834388;10501.4224217668;10572.78854422915;10584.576616935314;10587.84118238227;10376.688699339033;10511.84232236517;10531.578736850517;10532.631357902514;10536.104431123364;43063.56936430627;43338;43372.783136084116;43530;43532;3647.1064589175558;3663.981680091609;3738.401855703102;3772.5850156482766;3891.649751522348;32430.675693243236;32920;32929.176770580685;33053.3389332212;33670.15824604405;4158.459400277975;4185.393117997874;4257.6168144867115;4264.040590867061;4284.121755040209;303291;303412;303710;303887;304669.4766526175;58246.41753582495;58878.116828247614;66415.33584664189;66879.33120668828;72754.63622681853;65521.34478655248;65713.67143164254;65845;65923.67038164778;65978.34021659818;17462.38881639162;17558;17695.557611059827;17721.556961076076;17732.734008989875;13058.08593398472;13059.934700326437;13061.477540898257;13068.803967940488;13069.281189534668;21728.891355543437;22004.33986980393;22116.557668846533;22142.446438838837;22209.666854996864;7830.256125668053;7941;7949;8078.838423231502;8155.755327340189;981.249344251648;1031.1544533482622;1079.3146352066494;1120.4229821641861;1158.5771193514306;29993;30592.235194120323;30894.84552577268;33889.322213556086;35324.82337588296;1144.473542170594;1159.4087015622094;1162.9127815413879;1167.2529581068122;1257.0069644980547;13161.47354105825;14868.92565537187;15166.31751571182;15454.150021748686;16157;438326;439858;440872;443398;445284;59412;59528.70235648794;59739.402605974254;59824.102638460456;59902;1351.2433037499031;1428.757111291083;1534.5166272624087;1540.7688846673088;1556.4707999280072;30914.536281955337;31076.68923310738;31215.531767023967;31706.682933170374;32269.35461290808;45884.31173532466;46535;47314.763426182646;47544.7622761884;48709.26936096032;236756;475856;491898;492220;494376;35867;36493.635063649024;36628.63371366252;36744.26511469809;36750.63249367472;48014.759926200146;48419.5158048415;48800.2679959808;48983;49162;39634.207315852946;40439.1912161761;40757;40874.59125408827;41444.13501392384;36212.4568131473;36931.81534092312;37193.81403092967;37452.812735936146;37876.242475150895;39019.804900975316;39576.604233958446;40092.59907401005;40177.79911100426;40265.79867100646;34856.12859678528;35954.46068308925;38456;40102.79948600238;41080;25822.741772582784;25873.870630646725;25902.611460827724;26081.08716194924;26211.737882621692 02:29:19 INFO - 2016-02-04 02:29:19,691 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.58464857953413;384.720530854686;385.19109869274524;386.5747677554688;389.4080996884733;14618.85381146191;16515.33938642453;17976;19459.513512162204;19514.70727939082;11650.533978640866;11834.585789497369;12071.456784444721;18961.62076758464;19380.4185874424;4979.751012449372;5076.035553244872;5087.084324821531;5100.9489905100845;5107.7446127693465;4027.335489644205;4120.052387950773;5060.645754797166;6663.800085997428;6895.034695142684;6636.270010298863;6661.134052573158;6825.5222134450605;6850.691718872663;6873.587584744906;6843.452523798109;6865.176178858519;6884.759033433806;6885.793426197222;6889.552179108342;6509.804705858832;6615.272320044791;6656.36764507371;6661.26726060133;6661.800145995628;23734.64398034031;23783.643245351333;24152.879235603887;24197.758022419726;24360;2388.773066558674;2433.4038160650575;2552.0174732727846;2579.290695058855;2604.075553178632;13957.720845583133;15014.849851501454;15497.612559685986;15630.98398604087;15825.92087039569;2108.388567315477;2121.522657402072;2168.490404754881;2174.6846707227364;2212.4247695599097;74846.62576687137;76649.61675191588;78369;78381;78866;16316.102614356087;16899.23953422099;16916.407925722542;16927.576810579834;16941.83058169427;27117.186484405498;27261.591076133875;27654.72345276562;27690.44619107647;27694.861525692646;10193.643222487177;10371.429571373646;10375.94812025935;10388.688339349832;10439.582416703399;8848.778780530538;8850.20348168668;8860.601272942733;8883.244924181517;8916.821663566821;6851.153039832285;8456.534890581077;8459.365547583955;8515.233628973298;8563.357748168912;1873.634641244944;1940.7599481400275;1946.8150525700037;1947.2113793913488;1947.5228569000685;952.7618095476131;1005.7586179316911;1047.6280920273346;1083.6207327435334;1100.9339439633648;13612;15408.691826163638;16159.145367412048;16337.428190013292;17423.82576174222;1005.4118340770731;1011.4437059617181;1015.9339642923334;1081.605214096849;1115.2472081345059;8501.744947651581;10215.387076775418;10292;10344;10377.533011014371;471768;472687;481061;506888;617613;80288;85942.27317497473;88637.55681221552;89201;89220;1216.8053111502118;1228.8033914573625;1230.034422977958;1240.299230934519;1252.1798222164498;15595.610109747347;16173.110478923301;16205.59486012859;16322.102284374474;16397;34484.137896552784;34496.655033449344;34518.65481345155;34712.30575388428;38192.80903595464;46416.76791616155;48610.513894862015;48917.755411222715;49826.50173498219;52168.21747673712;9795.265355098538;9951.601935922483;10172.237082219011;10363.792724145625;10381.688549343531;12030.639080827239;12090.45592948337;13738.587842364745;17796.3771268005;17951.640967180843;15709.293081811118;15827.446039388566;16018.27917743681;16080.115593641995;16170.353185872433;2959.784670699077;3034.908952731422;14052.416633758326;14698.706025879637;14923.104613723212;16288.429904953744;16353;16369.836301636831;16537.586560336087;16597.83402165963;9516.762820833248;9678.903210967801;9726;9745.853812192965;9838.508074596384;10414.166866650801;12826.61520154397;15800.60498487547;15979.840201598301;16137.273822677773 02:29:19 INFO - 2016-02-04 02:29:19,692 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1550.6356006338513;1613.5639281039876;1619.757036444534;1812.1211212561914;1911.560341121543;7891.802704932379;8323.833523329546;8331.791705207374;8333.458325208858;8375.41372103953;7204.747833825817;7432.182459929403;7764.534127952327;7882.093559240689;8087.959560202191;2387.6060450025725;2404.495056038234;2429.392651837041;2431.0640403444713;2432.914847980321;2079.2826474866147;2364.4443555764383;2424.8787560621986;2428.174420696963;2435.9634605480933;2020.1818263603263;2288.5766133265315;2323.5933711600487;2341.637046257833;2342.9297121086393;2252.932412027642;2283.703118594589;2289.2445492987276;2291.598970180212;2292.85096468729;2308.5844547981355;2309.0648287443614;2345.237797715732;2345.7888790008983;2380.488195038075;8165.550894700789;8259.42184047117;8285.917140828635;8286.668533258662;8304.460210086325;4809.807607695723;4857;4897.191963326047;4897.461279259279;4903.092927808331;3165.5568220449154;3172.682731726832;3175.42842288388;3200.1519597306733;3222.7582931280012;1009.3035805294397;1043.1706793099504;1045.3884477580625;1058.1587637827945;1081.8052750504905;11024.779504409868;11040.116790656808;11044.502997365138;11055.668329950115;11082.390468524229;4395.142947125344;4422.938494761299;4477.6417886569;4479.731216127043;4493.438320209973;9259.861102083474;9300.162985331353;9326.253899688008;9366.484843333683;9398.624055037722;4908.828191013297;4939.382577177853;4942.28336891156;4952.950470495321;4982.451930287665;4439.911201775946;4460.955390446119;4472.351509031172;4513.796879140446;4521;3907.531096268466;3923.9803800981385;3934.213157368538;3937.586553411908;3985.4818873546255;1101.9173561982723;1102.8786833448314;1225.2036176485356;1229.274727910537;1238.4488902438509;1055.6094245129352;1175.5826681528106;1195.49789088583;1352.2765320553456;1461.4665647038755;7796.064472263365;7807;7890.763277101696;7904.0910295315625;7944.6027698614835;1157.2015309436463;1160.1762748448696;1170.4381896689636;1173.4484792147678;1182.763447310524;6104.175936248638;6149;6166;6184.752609895644;6207.6275423474735;9480.525973701288;10005.599776009023;10147.441890695934;10173.54219060144;10189.949050254701;9859.852102218472;10024.649137280307;10037.247206459544;10042.397456152654;10057.295989280827;7684.654190561439;7801.570913599807;7820.843583128306;7828.765137045898;7833.843323133506;7617.733379331697;7682.923170768444;7691.230876912264;7705.768826935201;7763.961180194063;8762.912370876209;8811.030786613339;8932.732018039469;9000.414973026733;9079.68221112258;8990.775230619025;9255.722328330161;9289.953550232205;9297.67458138962;9302.906970930204;6982.6159561222585;7047.1895731989425;7052.33002864727;7060.364567188978;7080.716771329296;7366.226546212785;7661.042369703787;7695.538267703956;8109.432339736162;8130.552819594979;6476.4495017924;7250.89123663156;7397.630118494161;7439.479236453396;7539.208383119693;6948.444124469929;7730.884036739566;7743.728969486041;7746.186650401852;7833.060032796101;7616.0860696716745;7663.463557550918;7664.578448185403;7669.69321227167;7687.461877668733;6954.408875245661;7028.648567571703;7054.8236294091;7084.326988936043;7096.467764917755;7179.066721326194;7228.349448549656;7229.132504099542;7240.239774823568;7249.311315425026 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: |4;prototype.html;346.34886413542534;350.14564462711;355.4330842306522;359.9532060832091;364.5006341312401;6139.72371243294;6166.4450199482035;6186.2885768136675;6186.56694031418;6198.163247961524;5830.271216097988;5919.691320385043;5988.880222395549;6101.054336577827;6103.7253323600435;4677.199278277871;4695.999999999992;4712;4720.858374248778;4728.290756386536;4697.201475749113;4700.3889494365685;4703.788329525162;4705.3177289293035;4717.551832575899;4511.548845115495;4551.772411379435;4599.632029437654;4626.467956185032;4659.720416774988;4619.468761092467;4632.953670463319;4641.791119399635;4661.603763680091;4673.813047478096;4080.2859499587453;4082.856800095978;4084.2233628371755;4091.8772436826944;4097.016715988141;5796.623219490762;5801.361850196475;5803.303603567557;5803.912941305884;5804.245448091763;5298.046351656701;5449.782008719647;5464.808731694411;5466.262054622614;5466.562674985991;6455.677216139175;6460.773872914472;6472.805815825533;6478.676066196718;6480.4491618212505;4572.222722137245;4578.175928332898;4579.061292435043;4580.831887868606;4583.931241031387;6658.866822663568;6731.730730770812;6769.120014398097;6791.592504449749;6807.625580593065;4701.19004183385;4701.858944231679;4702.764861756967;4702.788374523155;4711.858644240679;4771.093492236464;4772.188727916193;4776.832810851603;4779.928301075417;4784.521547845187;5463.3717122530625;5466.125419932871;5466.480684334982;5476.315460567429;5477.561795056386;6401.55189136756;6545.738170473223;6548.27968923418;6559.147310849559;6561.671916404161;1689.518487231158;1715.322447633178;1715.5882588178747;1715.836995485427;1719.2779032806002;1173.747644256489;1177.252444697606;1182.6511179202157;1203.8314635950974;1204.753025629744;6343.936560634427;6351.2696039956;6357.841053973688;6361.173047503888;6363.9045414318825;6728.226253980757;6730;6737.258901520829;6737.393634572912;6740.797776066725;6115.4801841843055;6212.409821066992;6268.341824108494;6357.904631430532;6358.078078678565;3639.94540081899;3654.154651900773;3673.8530458781884;3678.5217921670546;3687.6312368763447;6976.686049127801;6990.26602206761;6997;7004.4396448284015;7006.754763583352;6762.526623136333;6909.309069093151;6924.3421874921805;6938.5836849789175;6948.062011628466;6932.23745388007;6937.618430986243;6939.653017349112;6949.3745562899585;7003.334683204986;6814.897776533455;6819.283975182534;6826;6827.146606674166;6828.0440738297675;6524.967375163284;6712.865742685021;6741.089952856498;6741.325867413416;6746.527743057939;7016.122984626922;7030.964845175741;7032.613206273704;7035;7044.753433630003;4646.256598944153;4691.085238378483;4691.460482044472;4693.413323334583;4694.577488026094;6699.229588597374;6798.184217893884;6816.795496135124;6817.590944543145;6824.761133360308;6611.438027767694;6616.735330586723;6619.172603424572;6624.701888414937;6625.105610742681;6478.28738838718;6587;6597.472202223715;6600.1089852869245;6601.438877695257;6484.221893372825;6501.024846272908;6507.869842603027;6514.771982980573;6519.641419721961;6630.30381809903;6632.038354438483;6635.900461493178;6637.535372523877;6643.867122657423;6356.77751278703;6437.356264373525;6449.903251451326;6450.451711604566;6493.383128602775 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: |5;yui.html;843.4053991935685;852.9658813647452;887.4010043220825;907.1019690506398;963.4412041016211;14811.703765924689;14982.775258371134;15087.471938482155;15090.39638414465;15092.773608395883;13941.512047078355;14097.506587269447;14102.576922692335;14112.43550257991;14114.364853581588;756.7011030642893;768.6809973860841;898.8831451911242;910.5356268303146;934.0799312677008;913.7304495173906;915.6062892956027;921.9262459003263;922.2483675804232;922.4419226368051;787.9842403151933;976.1507488484992;977.0669011094424;977.5796407544752;977.9657711980082;791.6477167660394;793.9801504962364;940.2149205413454;948.6964171465133;949.2026697574071;707.6992278281762;710.7796583059268;712.3624356201223;713.414999700246;714.5748279773527;14391.2084835334;14424.855751442456;14513.129212247299;14559;14567.635809104751;12772.297523636196;12923.353832308441;13318.467261309535;13330.400131993987;13363.293507419157;11320.716982075432;11379.943100284529;11422.200445968785;11448.370339631318;11482.942585287105;3886.3198940185353;3956.3076461619103;3960.5445373782095;3968.1865217630316;3968.3650615901315;47902;47996.520034799905;48221.517784822056;48948;48982.51017489851;10279.94860025695;10337.9483102584;10419.739506512398;10554.894451055545;10706.571737130427;18483;18495.630087398178;18510.629787404447;18529.258829646933;18549.721754173697;8107.1892810718455;8208.507489550646;8414.158584141536;8525.914740852637;8723.738287851374;4800.279958006257;4929.876753081202;4993.350864387607;5020.196768517019;5051.191809310492;3184.9363012739614;3200.455922493182;3202.215457212951;3210.9036728898172;3211.582494275776;556.8385168301147;570.4096260370496;574.9827505174768;576.1501784867371;584.0742423259097;642.6208536963214;682.0144890632988;696.5054811084187;700.551646945955;708.4757279613152;9011.459312441144;9134.177923986741;9141.725748227564;9188.26493880488;9241.861372079424;614.2322097378277;672.7880717573948;679.4292794053019;708.4084789201074;728.0717085715755;4339.284018136972;4350.195213885441;4395.802188901507;4407.933880991788;4549.9990002199465;59102.40897591055;59374.70312648409;59421.40578594245;59434.40565594375;59680.10479842806;50279;50593.74703126461;51375.37621614073;51399.48600514022;53161.468385316424;45796.3130553042;45796.54203457989;46368.536314637095;46615;48115.75942120267;8996.55017249148;9114.361994660576;9276.860847087433;9308.627654893728;9414.985835552283;35740.46389304214;36409.089772754836;36645.26709465849;36668.63331366759;36719.449208261365;41858.37212441755;47700.522994769606;48148.759256204896;48258;48258.758706206245;10576.682699519026;10947.616833410792;11316.15128865322;11367.317960922372;11454.370009649549;12250;12615.283595156787;12741.299228542148;13057.869421306046;13092.410841511964;11750.29498230109;11781.882181178078;11812.70468238301;12038.75922481528;12282.754344912873;12269.93865030669;12455.439505222468;12465.750684986431;12797.488100475877;13014.089013769324;11382.430878455878;11521.711957201138;11764.235324703866;11968.640940771791;12054.216475929037;10442.843357349493;10888.128949684165;11045.83431248548;11056.391898445663;11525.711857203636;9633;9767.120959113714;9861.161801246973;9887.752806179904;9947.900520994697 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,827 02:29:19 INFO - 2016-02-04 02:29:19,696 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: __startTimestamp1454581759686__endTimestamp 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5533.78 Median:5741.45 stddev:614.11 (10.7%) stddev-sans-first:590.61 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: Values: 3306.3 3347.0 3348.8 3358.6 3360.2 5548.5 5577.6 5608.1 5624.4 5635.5 5568.4 5615.4 5629.0 5631.1 5633.7 4984.6 5064.9 5087.1 5093.8 5154.6 4967.1 5041.6 5064.9 5071.8 5126.6 5080.8 5084.6 5093.1 5094.3 5123.6 5073.0 5085.8 5132.8 5148.1 5157.7 4840.8 4910.9 4934.5 4998.4 5023.2 5349.0 5404.8 5406.1 5419.6 5445.6 5709.4 6008.0 6025.9 6028.2 6028.7 5762.5 5902.6 5922.6 5985.2 6005.7 5555.3 5578.3 5586.4 5596.8 5597.6 5946.1 6060.5 6065.2 6066.5 6067.2 5813.4 5882.2 5889.9 5890.8 5931.3 5919.1 6027.8 6039.8 6054.9 6059.0 5784.8 5786.3 5912.5 5981.3 6016.8 5941.7 5964.4 5975.2 5976.9 6006.3 4552.6 4585.5 4596.2 4599.3 4611.3 3974.1 4016.2 4085.8 4098.3 4141.3 5705.1 5734.9 5742.9 5743.1 5743.2 6037.1 6067.1 6068.8 6072.8 6075.5 5469.7 5568.0 5598.1 5643.0 5697.4 5160.6 5201.9 5204.9 5206.1 5218.3 6004.8 6170.4 6171.1 6179.2 6181.1 5892.3 5968.9 6038.3 6049.6 6078.4 6147.0 6157.8 6157.9 6158.9 6162.0 5617.5 5763.2 5907.8 5913.4 5915.4 5819.2 5905.0 5909.7 5928.2 5935.9 5755.0 5780.0 5800.2 5815.2 5857.8 5599.4 5664.6 5812.8 5815.6 5817.8 5681.0 5729.2 5737.1 5745.8 5778.7 5914.1 5919.5 5921.3 5924.6 5937.4 5435.8 5460.6 5696.4 5741.5 5770.6 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,698 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57113.57 Median:36841.22 stddev:106708.57 (289.6%) stddev-sans-first:106923.51 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: Values: 584.2 608.5 623.2 643.2 653.9 41782.6 42269.0 42297.8 42326.8 42460.6 46544.3 47069.5 47088.8 47119.5 47188.8 8165.3 8261.5 8880.4 9138.8 10230.3 10461.6 10517.0 10562.5 10568.3 10571.9 10607.4 10666.8 10690.1 10700.6 10703.5 10496.1 10501.4 10572.8 10584.6 10587.8 10376.7 10511.8 10531.6 10532.6 10536.1 43063.6 43338.0 43372.8 43530.0 43532.0 3647.1 3664.0 3738.4 3772.6 3891.6 32430.7 32920.0 32929.2 33053.3 33670.2 4158.5 4185.4 4257.6 4264.0 4284.1 303291.0 303412.0 303710.0 303887.0 304669.5 58246.4 58878.1 66415.3 66879.3 72754.6 65521.3 65713.7 65845.0 65923.7 65978.3 17462.4 17558.0 17695.6 17721.6 17732.7 13058.1 13059.9 13061.5 13068.8 13069.3 21728.9 22004.3 22116.6 22142.4 22209.7 7830.3 7941.0 7949.0 8078.8 8155.8 981.2 1031.2 1079.3 1120.4 1158.6 29993.0 30592.2 30894.8 33889.3 35324.8 1144.5 1159.4 1162.9 1167.3 1257.0 13161.5 14868.9 15166.3 15454.2 16157.0 438326.0 439858.0 440872.0 443398.0 445284.0 59412.0 59528.7 59739.4 59824.1 59902.0 1351.2 1428.8 1534.5 1540.8 1556.5 30914.5 31076.7 31215.5 31706.7 32269.4 45884.3 46535.0 47314.8 47544.8 48709.3 236756.0 475856.0 491898.0 492220.0 494376.0 35867.0 36493.6 36628.6 36744.3 36750.6 48014.8 48419.5 48800.3 48983.0 49162.0 39634.2 40439.2 40757.0 40874.6 41444.1 36212.5 36931.8 37193.8 37452.8 37876.2 39019.8 39576.6 40092.6 40177.8 40265.8 34856.1 35954.5 38456.0 40102.8 41080.0 25822.7 25873.9 25902.6 26081.1 26211.7 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29884.31 Median:13086.21 stddev:84057.03 (642.3%) stddev-sans-first:84263.65 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: Values: 384.6 384.7 385.2 386.6 389.4 14618.9 16515.3 17976.0 19459.5 19514.7 11650.5 11834.6 12071.5 18961.6 19380.4 4979.8 5076.0 5087.1 5100.9 5107.7 4027.3 4120.1 5060.6 6663.8 6895.0 6636.3 6661.1 6825.5 6850.7 6873.6 6843.5 6865.2 6884.8 6885.8 6889.6 6509.8 6615.3 6656.4 6661.3 6661.8 23734.6 23783.6 24152.9 24197.8 24360.0 2388.8 2433.4 2552.0 2579.3 2604.1 13957.7 15014.8 15497.6 15631.0 15825.9 2108.4 2121.5 2168.5 2174.7 2212.4 74846.6 76649.6 78369.0 78381.0 78866.0 16316.1 16899.2 16916.4 16927.6 16941.8 27117.2 27261.6 27654.7 27690.4 27694.9 10193.6 10371.4 10375.9 10388.7 10439.6 8848.8 8850.2 8860.6 8883.2 8916.8 6851.2 8456.5 8459.4 8515.2 8563.4 1873.6 1940.8 1946.8 1947.2 1947.5 952.8 1005.8 1047.6 1083.6 1100.9 13612.0 15408.7 16159.1 16337.4 17423.8 1005.4 1011.4 1015.9 1081.6 1115.2 8501.7 10215.4 10292.0 10344.0 10377.5 471768.0 472687.0 481061.0 506888.0 617613.0 80288.0 85942.3 88637.6 89201.0 89220.0 1216.8 1228.8 1230.0 1240.3 1252.2 15595.6 16173.1 16205.6 16322.1 16397.0 34484.1 34496.7 34518.7 34712.3 38192.8 46416.8 48610.5 48917.8 49826.5 52168.2 9795.3 9951.6 10172.2 10363.8 10381.7 12030.6 12090.5 13738.6 17796.4 17951.6 15709.3 15827.4 16018.3 16080.1 16170.4 2959.8 3034.9 14052.4 14698.7 14923.1 16288.4 16353.0 16369.8 16537.6 16597.8 9516.8 9678.9 9726.0 9745.9 9838.5 10414.2 12826.6 15800.6 15979.8 16137.3 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,699 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5769.16 Median:4947.62 stddev:2996.17 (60.6%) stddev-sans-first:2987.80 02:29:19 INFO - 2016-02-04 02:29:19,700 DEBUG : BROWSER_OUTPUT: Values: 1550.6 1613.6 1619.8 1812.1 1911.6 7891.8 8323.8 8331.8 8333.5 8375.4 7204.7 7432.2 7764.5 7882.1 8088.0 2387.6 2404.5 2429.4 2431.1 2432.9 2079.3 2364.4 2424.9 2428.2 2436.0 2020.2 2288.6 2323.6 2341.6 2342.9 2252.9 2283.7 2289.2 2291.6 2292.9 2308.6 2309.1 2345.2 2345.8 2380.5 8165.6 8259.4 8285.9 8286.7 8304.5 4809.8 4857.0 4897.2 4897.5 4903.1 3165.6 3172.7 3175.4 3200.2 3222.8 1009.3 1043.2 1045.4 1058.2 1081.8 11024.8 11040.1 11044.5 11055.7 11082.4 4395.1 4422.9 4477.6 4479.7 4493.4 9259.9 9300.2 9326.3 9366.5 9398.6 4908.8 4939.4 4942.3 4953.0 4982.5 4439.9 4461.0 4472.4 4513.8 4521.0 3907.5 3924.0 3934.2 3937.6 3985.5 1101.9 1102.9 1225.2 1229.3 1238.4 1055.6 1175.6 1195.5 1352.3 1461.5 7796.1 7807.0 7890.8 7904.1 7944.6 1157.2 1160.2 1170.4 1173.4 1182.8 6104.2 6149.0 6166.0 6184.8 6207.6 9480.5 10005.6 10147.4 10173.5 10189.9 9859.9 10024.6 10037.2 10042.4 10057.3 7684.7 7801.6 7820.8 7828.8 7833.8 7617.7 7682.9 7691.2 7705.8 7764.0 8762.9 8811.0 8932.7 9000.4 9079.7 8990.8 9255.7 9290.0 9297.7 9302.9 6982.6 7047.2 7052.3 7060.4 7080.7 7366.2 7661.0 7695.5 8109.4 8130.6 6476.4 7250.9 7397.6 7439.5 7539.2 6948.4 7730.9 7743.7 7746.2 7833.1 7616.1 7663.5 7664.6 7669.7 7687.5 6954.4 7028.6 7054.8 7084.3 7096.5 7179.1 7228.3 7229.1 7240.2 7249.3 02:29:19 INFO - 2016-02-04 02:29:19,700 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,700 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5481.03 Median:6205.29 stddev:1642.28 (26.5%) stddev-sans-first:1601.03 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: Values: 346.3 350.1 355.4 360.0 364.5 6139.7 6166.4 6186.3 6186.6 6198.2 5830.3 5919.7 5988.9 6101.1 6103.7 4677.2 4696.0 4712.0 4720.9 4728.3 4697.2 4700.4 4703.8 4705.3 4717.6 4511.5 4551.8 4599.6 4626.5 4659.7 4619.5 4633.0 4641.8 4661.6 4673.8 4080.3 4082.9 4084.2 4091.9 4097.0 5796.6 5801.4 5803.3 5803.9 5804.2 5298.0 5449.8 5464.8 5466.3 5466.6 6455.7 6460.8 6472.8 6478.7 6480.4 4572.2 4578.2 4579.1 4580.8 4583.9 6658.9 6731.7 6769.1 6791.6 6807.6 4701.2 4701.9 4702.8 4702.8 4711.9 4771.1 4772.2 4776.8 4779.9 4784.5 5463.4 5466.1 5466.5 5476.3 5477.6 6401.6 6545.7 6548.3 6559.1 6561.7 1689.5 1715.3 1715.6 1715.8 1719.3 1173.7 1177.3 1182.7 1203.8 1204.8 6343.9 6351.3 6357.8 6361.2 6363.9 6728.2 6730.0 6737.3 6737.4 6740.8 6115.5 6212.4 6268.3 6357.9 6358.1 3639.9 3654.2 3673.9 3678.5 3687.6 6976.7 6990.3 6997.0 7004.4 7006.8 6762.5 6909.3 6924.3 6938.6 6948.1 6932.2 6937.6 6939.7 6949.4 7003.3 6814.9 6819.3 6826.0 6827.1 6828.0 6525.0 6712.9 6741.1 6741.3 6746.5 7016.1 7031.0 7032.6 7035.0 7044.8 4646.3 4691.1 4691.5 4693.4 4694.6 6699.2 6798.2 6816.8 6817.6 6824.8 6611.4 6616.7 6619.2 6624.7 6625.1 6478.3 6587.0 6597.5 6600.1 6601.4 6484.2 6501.0 6507.9 6514.8 6519.6 6630.3 6632.0 6635.9 6637.5 6643.9 6356.8 6437.4 6449.9 6450.5 6493.4 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14374.54 Median:47801.26 stddev:16216.69 (33.9%) stddev-sans-first:16230.35 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: Values: 843.4 853.0 887.4 907.1 963.4 14811.7 14982.8 15087.5 15090.4 15092.8 13941.5 14097.5 14102.6 14112.4 14114.4 756.7 768.7 898.9 910.5 934.1 913.7 915.6 921.9 922.2 922.4 788.0 976.2 977.1 977.6 978.0 791.6 794.0 940.2 948.7 949.2 707.7 710.8 712.4 713.4 714.6 14391.2 14424.9 14513.1 14559.0 14567.6 12772.3 12923.4 13318.5 13330.4 13363.3 11320.7 11379.9 11422.2 11448.4 11482.9 3886.3 3956.3 3960.5 3968.2 3968.4 47902.0 47996.5 48221.5 48948.0 48982.5 10279.9 10337.9 10419.7 10554.9 10706.6 18483.0 18495.6 18510.6 18529.3 18549.7 8107.2 8208.5 8414.2 8525.9 8723.7 4800.3 4929.9 4993.4 5020.2 5051.2 3184.9 3200.5 3202.2 3210.9 3211.6 556.8 570.4 575.0 576.2 584.1 642.6 682.0 696.5 700.6 708.5 9011.5 9134.2 9141.7 9188.3 9241.9 614.2 672.8 679.4 708.4 728.1 4339.3 4350.2 4395.8 4407.9 4550.0 59102.4 59374.7 59421.4 59434.4 59680.1 50279.0 50593.7 51375.4 51399.5 53161.5 45796.3 45796.5 46368.5 46615.0 48115.8 8996.6 9114.4 9276.9 9308.6 9415.0 35740.5 36409.1 36645.3 36668.6 36719.4 41858.4 47700.5 48148.8 48258.0 48258.8 10576.7 10947.6 11316.2 11367.3 11454.4 12250.0 12615.3 12741.3 13057.9 13092.4 11750.3 11781.9 11812.7 12038.8 12282.8 12269.9 12455.4 12465.8 12797.5 13014.1 11382.4 11521.7 11764.2 11968.6 12054.2 10442.8 10888.1 11045.8 11056.4 11525.7 9633.0 9767.1 9861.2 9887.8 9947.9 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:29:19 INFO - 2016-02-04 02:29:19,702 DEBUG : BROWSER_OUTPUT: 02:29:20 INFO - 2016-02-04 02:29:20,249 INFO : Browser exited with error code: 0 02:29:20 INFO - 2016-02-04 02:29:20,267 INFO : Completed test dromaeo_css (00:18:29) 02:29:20 INFO - 2016-02-04 02:29:20,267 INFO : Starting test kraken 02:29:20 INFO - 2016-02-04 02:29:20,267 DEBUG : operating with platform_type : linux_ 02:29:20 INFO - 2016-02-04 02:29:20,268 INFO : Initialising browser for kraken test... 02:29:20 INFO - 2016-02-04 02:29:20,274 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNri6kF/profile http://localhost:57433/getInfo.html 02:29:24 INFO - 2016-02-04 02:29:24,050 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:29:24 INFO - 2016-02-04 02:29:24,051 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:29:24 INFO - 2016-02-04 02:29:24,051 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:29:24 INFO - 2016-02-04 02:29:24,051 DEBUG : BROWSER_OUTPUT: __metrics 02:29:24 INFO - 2016-02-04 02:29:24,309 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] 02:29:25 INFO - 2016-02-04 02:29:25,144 INFO : Browser initialized. 02:29:25 INFO - 2016-02-04 02:29:25,145 INFO : Running cycle 1/1 for kraken test... 02:29:25 INFO - 2016-02-04 02:29:25,145 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNri6kF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:29:36 INFO - 2016-02-04 02:29:36,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 134295552 02:29:36 INFO - 2016-02-04 02:29:36,972 DEBUG : BROWSER_OUTPUT: 02:29:39 INFO - 2016-02-04 02:29:39,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57433/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:39 INFO - 2016-02-04 02:29:39,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 165675008 02:29:39 INFO - 2016-02-04 02:29:39,973 DEBUG : BROWSER_OUTPUT: 02:29:42 INFO - 2016-02-04 02:29:42,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57433/tests/kraken/driver.html?testName=audio-dft) 02:29:43 INFO - 2016-02-04 02:29:43,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 163897344 02:29:43 INFO - 2016-02-04 02:29:43,095 DEBUG : BROWSER_OUTPUT: 02:29:45 INFO - 2016-02-04 02:29:45,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57433/tests/kraken/driver.html?testName=audio-fft) 02:29:46 INFO - 2016-02-04 02:29:46,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 160370688 02:29:46 INFO - 2016-02-04 02:29:46,441 DEBUG : BROWSER_OUTPUT: 02:29:48 INFO - 2016-02-04 02:29:48,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57433/tests/kraken/driver.html?testName=audio-oscillator) 02:29:48 INFO - 2016-02-04 02:29:48,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 159236096 02:29:48 INFO - 2016-02-04 02:29:48,969 DEBUG : BROWSER_OUTPUT: 02:29:51 INFO - 2016-02-04 02:29:51,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:29:51 INFO - 2016-02-04 02:29:51,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 160239616 02:29:51 INFO - 2016-02-04 02:29:51,699 DEBUG : BROWSER_OUTPUT: 02:29:54 INFO - 2016-02-04 02:29:54,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57433/tests/kraken/driver.html?testName=imaging-darkroom) 02:29:55 INFO - 2016-02-04 02:29:55,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 158109696 02:29:55 INFO - 2016-02-04 02:29:55,099 DEBUG : BROWSER_OUTPUT: 02:29:58 INFO - 2016-02-04 02:29:58,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57433/tests/kraken/driver.html?testName=imaging-desaturate) 02:29:59 INFO - 2016-02-04 02:29:59,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 160092160 02:29:59 INFO - 2016-02-04 02:29:59,019 DEBUG : BROWSER_OUTPUT: 02:30:01 INFO - 2016-02-04 02:30:01,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57433/tests/kraken/driver.html?testName=json-parse-financial) 02:30:02 INFO - 2016-02-04 02:30:02,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 161148928 02:30:02 INFO - 2016-02-04 02:30:02,295 DEBUG : BROWSER_OUTPUT: 02:30:03 INFO - 2016-02-04 02:30:03,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:04 INFO - 2016-02-04 02:30:04,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 167219200 02:30:04 INFO - 2016-02-04 02:30:04,405 DEBUG : BROWSER_OUTPUT: 02:30:06 INFO - 2016-02-04 02:30:06,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:06 INFO - 2016-02-04 02:30:06,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 164290560 02:30:06 INFO - 2016-02-04 02:30:06,758 DEBUG : BROWSER_OUTPUT: 02:30:08 INFO - 2016-02-04 02:30:08,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:09 INFO - 2016-02-04 02:30:09,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 168173568 02:30:09 INFO - 2016-02-04 02:30:09,291 DEBUG : BROWSER_OUTPUT: 02:30:11 INFO - 2016-02-04 02:30:11,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:12 INFO - 2016-02-04 02:30:12,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 175177728 02:30:12 INFO - 2016-02-04 02:30:12,192 DEBUG : BROWSER_OUTPUT: 02:30:14 INFO - 2016-02-04 02:30:14,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:15 INFO - 2016-02-04 02:30:15,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 172617728 02:30:15 INFO - 2016-02-04 02:30:15,205 DEBUG : BROWSER_OUTPUT: 02:30:16 INFO - 2016-02-04 02:30:16,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57433/tests/kraken/driver.html?testName=ai-astar) 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 231477248 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;104;109;111;109;98;110;110;110 02:30:17 INFO - 2016-02-04 02:30:17,093 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;130;158;164;121;149;159;122;161;122 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;160;160;162;161;164;159;159 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;72;152;71;72;73;73;153;72 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;136;92;92;92;138;92;92;134 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;109;109;109;109;109;110 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;146;145;146;145;145;145;146 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;95;95;95;95;95 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;56;57;56;60;56;56;56;54;55 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;66;65;66;66;66;66;65;66 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;74;75;76;76;78;77;79;77;84 02:30:17 INFO - 2016-02-04 02:30:17,094 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;112;115;111;118;109;126;119;108;112 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;130;144;139;138;138;137;141;140;142;131 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;61;64;64;64;62;63;64;63;66 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,880 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: __startTimestamp1454581817087__endTimestamp 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:30:17 INFO - 2016-02-04 02:30:17,095 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:4.07 (3.7%) stddev-sans-first:4.30 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 104.0 109.0 111.0 109.0 98.0 110.0 110.0 110.0 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:153.50 stddev:17.72 (11.5%) stddev-sans-first:18.76 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: Values: 146.0 130.0 158.0 164.0 121.0 149.0 159.0 122.0 161.0 122.0 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 160.0 160.0 162.0 161.0 164.0 159.0 159.0 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:34.06 (47.3%) stddev-sans-first:35.51 02:30:17 INFO - 2016-02-04 02:30:17,096 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 152.0 71.0 72.0 73.0 73.0 153.0 72.0 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.00 stddev:21.14 (23.0%) stddev-sans-first:21.94 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 136.0 92.0 92.0 92.0 138.0 92.0 92.0 134.0 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:30:17 INFO - 2016-02-04 02:30:17,097 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.64 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: Values: 54.0 56.0 57.0 56.0 60.0 56.0 56.0 56.0 54.0 55.0 02:30:17 INFO - 2016-02-04 02:30:17,098 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,099 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 02:30:17 INFO - 2016-02-04 02:30:17,099 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 02:30:17 INFO - 2016-02-04 02:30:17,099 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.78 (3.6%) stddev-sans-first:2.92 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: Values: 76.0 74.0 75.0 76.0 76.0 78.0 77.0 79.0 77.0 84.0 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:116.50 stddev:5.59 (4.8%) stddev-sans-first:5.73 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: Values: 119.0 112.0 115.0 111.0 118.0 109.0 126.0 119.0 108.0 112.0 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:139.50 stddev:4.47 (3.2%) stddev-sans-first:3.69 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: Values: 130.0 144.0 139.0 138.0 138.0 137.0 141.0 140.0 142.0 131.0 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.42 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: Values: 65.0 61.0 64.0 64.0 64.0 62.0 63.0 64.0 63.0 66.0 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:30:17 INFO - 2016-02-04 02:30:17,100 DEBUG : BROWSER_OUTPUT: 02:30:17 INFO - 2016-02-04 02:30:17,729 INFO : Browser exited with error code: 0 02:30:17 INFO - 2016-02-04 02:30:17,780 INFO : Completed test kraken (00:00:57) 02:30:17 INFO - 2016-02-04 02:30:17,780 INFO : Starting test v8_7 02:30:17 INFO - 2016-02-04 02:30:17,780 DEBUG : operating with platform_type : linux_ 02:30:17 INFO - 2016-02-04 02:30:17,781 INFO : Initialising browser for v8_7 test... 02:30:17 INFO - 2016-02-04 02:30:17,787 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDEASzI/profile http://localhost:57433/getInfo.html 02:30:21 INFO - 2016-02-04 02:30:21,905 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:30:21 INFO - 2016-02-04 02:30:21,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:30:21 INFO - 2016-02-04 02:30:21,905 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:30:21 INFO - 2016-02-04 02:30:21,905 DEBUG : BROWSER_OUTPUT: __metrics 02:30:22 INFO - 2016-02-04 02:30:22,074 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] 02:30:22 INFO - 2016-02-04 02:30:22,758 INFO : Browser initialized. 02:30:22 INFO - 2016-02-04 02:30:22,759 INFO : Running cycle 1/1 for v8_7 test... 02:30:22 INFO - 2016-02-04 02:30:22,759 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDEASzI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:30:34 INFO - 2016-02-04 02:30:34,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 134332416 02:30:34 INFO - 2016-02-04 02:30:34,442 DEBUG : BROWSER_OUTPUT: 02:30:55 INFO - 2016-02-04 02:30:55,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57433/tests/v8_7/run.html (next: http://localhost:57433/tests/v8_7/run.html) 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 412893184 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:30:56 INFO - 2016-02-04 02:30:56,004 DEBUG : BROWSER_OUTPUT: |0;Richards;168.37851490149856 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.01650165016503 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |4;RayTrace;965.2509652509652 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |6;Boyer;10536.842105263158 02:30:56 INFO - 2016-02-04 02:30:56,005 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: |8;Splay;492.4205378973105 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1454581856003__endTimestamp 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.38 Median:168.38 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: Values: 168.4 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,008 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: Values: 165.0 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: Values: 279.8 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: Values: 5148.7 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:965.25 Median:965.25 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: Values: 965.3 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: Values: 542.6 02:30:56 INFO - 2016-02-04 02:30:56,009 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10536.84 Median:10536.84 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: Values: 10536.8 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: Values: 26815.8 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:492.42 Median:492.42 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: Values: 492.4 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: Values: 4822.1 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:30:56 INFO - 2016-02-04 02:30:56,010 DEBUG : BROWSER_OUTPUT: 02:30:56 INFO - 2016-02-04 02:30:56,557 INFO : Browser exited with error code: 0 02:30:56 INFO - 2016-02-04 02:30:56,574 INFO : Completed test v8_7 (00:00:38) 02:30:56 INFO - 2016-02-04 02:30:56,598 INFO : Completed test suite (00:20:06) 02:30:56 INFO - 2016-02-04 02:30:56,598 DEBUG : Working with test: dromaeo_css 02:30:56 INFO - 2016-02-04 02:30:56,598 DEBUG : Generating results file: dromaeo_css 02:30:56 INFO - 2016-02-04 02:30:56,599 DEBUG : Working with test: kraken 02:30:56 INFO - 2016-02-04 02:30:56,599 DEBUG : Generating results file: kraken 02:30:56 INFO - 2016-02-04 02:30:56,600 INFO : javascript benchmark 02:30:56 INFO - 2016-02-04 02:30:56,600 DEBUG : Working with test: v8_7 02:30:56 INFO - 2016-02-04 02:30:56,600 DEBUG : Generating results file: v8_7 02:30:56 INFO - 2016-02-04 02:30:56,601 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:56 INFO - 2016-02-04 02:30:56,658 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 02:30:56 INFO - 2016-02-04 02:30:56,658 DEBUG : process_Request line: dromaeo_css 7518.86 graph.html#tests=[[72,53,35]] 02:30:56 INFO - 2016-02-04 02:30:56,658 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:56 INFO - 2016-02-04 02:30:56,693 DEBUG : process_Request line: kraken 1470.60 graph.html#tests=[[232,53,35]] 02:30:56 INFO - 2016-02-04 02:30:56,693 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:30:56 INFO - 2016-02-04 02:30:56,729 DEBUG : process_Request line: v8_7 23156.48 graph.html#tests=[[230,53,35]] 02:30:56 INFO - 2016-02-04 02:30:56,730 INFO : javascript benchmark 02:30:56 INFO - 2016-02-04 02:30:56,734 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3306.3222039481907, 3347.0460918638178, 3348.7655864089525, 3358.580177477815, 3360.17675669461, 5548.528375088117, 5577.581681373903, 5608.130739735342, 5624.3813180550105, 5635.464630860072, 5568.443155684429, 5615.354234263051, 5629.043062679344, 5631.0708733059, 5633.690147041911, 4984.601231901439, 5064.873378165538, 5087.135187018197, 5093.821716239932, 5154.639175257734, 4967.0810899983435, 5041.571466425358, 5064.860406408547, 5071.797128114871, 5126.615503837227, 5080.77136528857, 5084.618653600976, 5093.0577843099145, 5094.337736094321, 5123.641345105844, 5073.0, 5085.771140298695, 5132.794688212448, 5148.099082660538, 5157.742112894341, 4840.806367745286, 4910.901781964377, 4934.531219534175, 4998.375203099613, 5023.196288593807, 5348.983693098299, 5404.756785944642, 5406.107992181285, 5419.620626556142, 5445.591580631469, 5709.4290570942985, 6008.0, 6025.879482410327, 6028.246469191351, 6028.668423236721, 5762.510186634141, 5902.61632993854, 5922.58541902067, 5985.221921150222, 6005.6997150142315, 5555.30558680165, 5578.30271216098, 5586.413426590231, 5596.804111856106, 5597.63615365, 5946.108083787466, 6060.484858786965, 6065.2418447694035, 6066.4540191382985, 6067.24159480065, 5813.360530341659, 5882.176495290662, 5889.882202356014, 5890.823275301748, 5931.317898441648, 5919.141724449931, 6027.819165424957, 6039.818805435844, 6054.878902421927, 6058.969705151534, 5784.82645520635, 5786.305643322744, 5912.526997840162, 5981.252343457068, 6016.789412370546, 5941.673207973603, 5964.433378829004, 5975.163477113208, 5976.880462390728, 6006.339302676702, 4552.590266875931, 4585.518520555293, 4596.2416201326405, 4599.33309670096, 4611.262198048296, 3974.066094467798, 4016.156607112539, 4085.8365665373053, 4098.344264917659, 4141.254574176617, 5705.058665320259, 5734.885302293931, 5742.942570574241, 5743.052396354638, 5743.2246646703, 6037.1246169305205, 6067.1202675611785, 6068.787592434243, 6072.817815465543, 6075.453209211192, 5469.699166545878, 5568.0, 5598.10430331145, 5643.0, 5697.4302569742695, 5160.612954028463, 5201.921971170435, 5204.921926171035, 5206.114960456732, 5218.269442278084, 6004.849878752979, 6170.413810687977, 6171.105189747462, 6179.16581261533, 6181.134641150243, 5892.322382926019, 5968.910466342922, 6038.3357830637715, 6049.606775559574, 6078.392160784063, 6147.047207682816, 6157.84605384869, 6157.907631385622, 6158.876822463615, 6162.044883043135, 5617.522510586646, 5763.221965034667, 5907.822765317047, 5913.408659134052, 5915.37888521699, 5819.214406055128, 5904.9704751475965, 5909.674967876636, 5928.199693041384, 5935.881282374415, 5755.0, 5779.971100144472, 5800.158976948234, 5815.185873977731, 5857.7949771757785, 5599.412061733622, 5664.5751568631695, 5812.7674893003805, 5815.5929084963645, 5817.76728930838, 5681.0058239808695, 5729.197912292199, 5737.053386191232, 5745.770169193185, 5778.653280802997, 5914.112883067574, 5919.526437884872, 5921.348651648229, 5924.585279030426, 5937.406259374201, 5435.782568697208, 5460.6177567569885, 5696.430356964271, 5741.45456181662, 5770.596058275881], "unit": "ms", "name": "dojo.html", "value": 5494.013529123425}, {"lowerIsBetter": false, "replicates": [584.2229834320354, 608.4645511949485, 623.1898531908521, 643.1960049937575, 653.9444147247484, 41782.58217417825, 42269.0, 42297.78851105744, 42326.78836605813, 42460.57539424609, 46544.30183547241, 47069.52930470694, 47088.76455617717, 47119.52880471194, 47188.76405617967, 8165.3059489943425, 8261.463004904663, 8880.422772519765, 9138.77153071172, 10230.283880128394, 10461.633842815503, 10517.0, 10562.471876406187, 10568.313059651098, 10571.947140264288, 10607.363558186495, 10666.78666426671, 10690.091342235919, 10700.625478108268, 10703.518341674644, 10496.107830834388, 10501.4224217668, 10572.78854422915, 10584.576616935314, 10587.84118238227, 10376.688699339033, 10511.84232236517, 10531.578736850517, 10532.631357902514, 10536.104431123364, 43063.56936430627, 43338.0, 43372.783136084116, 43530.0, 43532.0, 3647.1064589175558, 3663.981680091609, 3738.401855703102, 3772.5850156482766, 3891.649751522348, 32430.675693243236, 32920.0, 32929.176770580685, 33053.3389332212, 33670.15824604405, 4158.459400277975, 4185.393117997874, 4257.6168144867115, 4264.040590867061, 4284.121755040209, 303291.0, 303412.0, 303710.0, 303887.0, 304669.4766526175, 58246.41753582495, 58878.116828247614, 66415.33584664189, 66879.33120668828, 72754.63622681853, 65521.34478655248, 65713.67143164254, 65845.0, 65923.67038164778, 65978.34021659818, 17462.38881639162, 17558.0, 17695.557611059827, 17721.556961076076, 17732.734008989875, 13058.08593398472, 13059.934700326437, 13061.477540898257, 13068.803967940488, 13069.281189534668, 21728.891355543437, 22004.33986980393, 22116.557668846533, 22142.446438838837, 22209.666854996864, 7830.256125668053, 7941.0, 7949.0, 8078.838423231502, 8155.755327340189, 981.249344251648, 1031.1544533482622, 1079.3146352066494, 1120.4229821641861, 1158.5771193514306, 29993.0, 30592.235194120323, 30894.84552577268, 33889.322213556086, 35324.82337588296, 1144.473542170594, 1159.4087015622094, 1162.9127815413879, 1167.2529581068122, 1257.0069644980547, 13161.47354105825, 14868.92565537187, 15166.31751571182, 15454.150021748686, 16157.0, 438326.0, 439858.0, 440872.0, 443398.0, 445284.0, 59412.0, 59528.70235648794, 59739.402605974254, 59824.102638460456, 59902.0, 1351.2433037499031, 1428.757111291083, 1534.5166272624087, 1540.7688846673088, 1556.4707999280072, 30914.536281955337, 31076.68923310738, 31215.531767023967, 31706.682933170374, 32269.35461290808, 45884.31173532466, 46535.0, 47314.763426182646, 47544.7622761884, 48709.26936096032, 236756.0, 475856.0, 491898.0, 492220.0, 494376.0, 35867.0, 36493.635063649024, 36628.63371366252, 36744.26511469809, 36750.63249367472, 48014.759926200146, 48419.5158048415, 48800.2679959808, 48983.0, 49162.0, 39634.207315852946, 40439.1912161761, 40757.0, 40874.59125408827, 41444.13501392384, 36212.4568131473, 36931.81534092312, 37193.81403092967, 37452.812735936146, 37876.242475150895, 39019.804900975316, 39576.604233958446, 40092.59907401005, 40177.79911100426, 40265.79867100646, 34856.12859678528, 35954.46068308925, 38456.0, 40102.79948600238, 41080.0, 25822.741772582784, 25873.870630646725, 25902.611460827724, 26081.08716194924, 26211.737882621692], "unit": "ms", "name": "ext.html", "value": 20769.950228334645}, {"lowerIsBetter": false, "replicates": [384.58464857953413, 384.720530854686, 385.19109869274524, 386.5747677554688, 389.4080996884733, 14618.85381146191, 16515.33938642453, 17976.0, 19459.513512162204, 19514.70727939082, 11650.533978640866, 11834.585789497369, 12071.456784444721, 18961.62076758464, 19380.4185874424, 4979.751012449372, 5076.035553244872, 5087.084324821531, 5100.9489905100845, 5107.7446127693465, 4027.335489644205, 4120.052387950773, 5060.645754797166, 6663.800085997428, 6895.034695142684, 6636.270010298863, 6661.134052573158, 6825.5222134450605, 6850.691718872663, 6873.587584744906, 6843.452523798109, 6865.176178858519, 6884.759033433806, 6885.793426197222, 6889.552179108342, 6509.804705858832, 6615.272320044791, 6656.36764507371, 6661.26726060133, 6661.800145995628, 23734.64398034031, 23783.643245351333, 24152.879235603887, 24197.758022419726, 24360.0, 2388.773066558674, 2433.4038160650575, 2552.0174732727846, 2579.290695058855, 2604.075553178632, 13957.720845583133, 15014.849851501454, 15497.612559685986, 15630.98398604087, 15825.92087039569, 2108.388567315477, 2121.522657402072, 2168.490404754881, 2174.6846707227364, 2212.4247695599097, 74846.62576687137, 76649.61675191588, 78369.0, 78381.0, 78866.0, 16316.102614356087, 16899.23953422099, 16916.407925722542, 16927.576810579834, 16941.83058169427, 27117.186484405498, 27261.591076133875, 27654.72345276562, 27690.44619107647, 27694.861525692646, 10193.643222487177, 10371.429571373646, 10375.94812025935, 10388.688339349832, 10439.582416703399, 8848.778780530538, 8850.20348168668, 8860.601272942733, 8883.244924181517, 8916.821663566821, 6851.153039832285, 8456.534890581077, 8459.365547583955, 8515.233628973298, 8563.357748168912, 1873.634641244944, 1940.7599481400275, 1946.8150525700037, 1947.2113793913488, 1947.5228569000685, 952.7618095476131, 1005.7586179316911, 1047.6280920273346, 1083.6207327435334, 1100.9339439633648, 13612.0, 15408.691826163638, 16159.145367412048, 16337.428190013292, 17423.82576174222, 1005.4118340770731, 1011.4437059617181, 1015.9339642923334, 1081.605214096849, 1115.2472081345059, 8501.744947651581, 10215.387076775418, 10292.0, 10344.0, 10377.533011014371, 471768.0, 472687.0, 481061.0, 506888.0, 617613.0, 80288.0, 85942.27317497473, 88637.55681221552, 89201.0, 89220.0, 1216.8053111502118, 1228.8033914573625, 1230.034422977958, 1240.299230934519, 1252.1798222164498, 15595.610109747347, 16173.110478923301, 16205.59486012859, 16322.102284374474, 16397.0, 34484.137896552784, 34496.655033449344, 34518.65481345155, 34712.30575388428, 38192.80903595464, 46416.76791616155, 48610.513894862015, 48917.755411222715, 49826.50173498219, 52168.21747673712, 9795.265355098538, 9951.601935922483, 10172.237082219011, 10363.792724145625, 10381.688549343531, 12030.639080827239, 12090.45592948337, 13738.587842364745, 17796.3771268005, 17951.640967180843, 15709.293081811118, 15827.446039388566, 16018.27917743681, 16080.115593641995, 16170.353185872433, 2959.784670699077, 3034.908952731422, 14052.416633758326, 14698.706025879637, 14923.104613723212, 16288.429904953744, 16353.0, 16369.836301636831, 16537.586560336087, 16597.83402165963, 9516.762820833248, 9678.903210967801, 9726.0, 9745.853812192965, 9838.508074596384, 10414.166866650801, 12826.61520154397, 15800.60498487547, 15979.840201598301, 16137.273822677773], "unit": "ms", "name": "jquery.html", "value": 10053.09010601613}, {"lowerIsBetter": false, "replicates": [1550.6356006338513, 1613.5639281039876, 1619.757036444534, 1812.1211212561914, 1911.560341121543, 7891.802704932379, 8323.833523329546, 8331.791705207374, 8333.458325208858, 8375.41372103953, 7204.747833825817, 7432.182459929403, 7764.534127952327, 7882.093559240689, 8087.959560202191, 2387.6060450025725, 2404.495056038234, 2429.392651837041, 2431.0640403444713, 2432.914847980321, 2079.2826474866147, 2364.4443555764383, 2424.8787560621986, 2428.174420696963, 2435.9634605480933, 2020.1818263603263, 2288.5766133265315, 2323.5933711600487, 2341.637046257833, 2342.9297121086393, 2252.932412027642, 2283.703118594589, 2289.2445492987276, 2291.598970180212, 2292.85096468729, 2308.5844547981355, 2309.0648287443614, 2345.237797715732, 2345.7888790008983, 2380.488195038075, 8165.550894700789, 8259.42184047117, 8285.917140828635, 8286.668533258662, 8304.460210086325, 4809.807607695723, 4857.0, 4897.191963326047, 4897.461279259279, 4903.092927808331, 3165.5568220449154, 3172.682731726832, 3175.42842288388, 3200.1519597306733, 3222.7582931280012, 1009.3035805294397, 1043.1706793099504, 1045.3884477580625, 1058.1587637827945, 1081.8052750504905, 11024.779504409868, 11040.116790656808, 11044.502997365138, 11055.668329950115, 11082.390468524229, 4395.142947125344, 4422.938494761299, 4477.6417886569, 4479.731216127043, 4493.438320209973, 9259.861102083474, 9300.162985331353, 9326.253899688008, 9366.484843333683, 9398.624055037722, 4908.828191013297, 4939.382577177853, 4942.28336891156, 4952.950470495321, 4982.451930287665, 4439.911201775946, 4460.955390446119, 4472.351509031172, 4513.796879140446, 4521.0, 3907.531096268466, 3923.9803800981385, 3934.213157368538, 3937.586553411908, 3985.4818873546255, 1101.9173561982723, 1102.8786833448314, 1225.2036176485356, 1229.274727910537, 1238.4488902438509, 1055.6094245129352, 1175.5826681528106, 1195.49789088583, 1352.2765320553456, 1461.4665647038755, 7796.064472263365, 7807.0, 7890.763277101696, 7904.0910295315625, 7944.6027698614835, 1157.2015309436463, 1160.1762748448696, 1170.4381896689636, 1173.4484792147678, 1182.763447310524, 6104.175936248638, 6149.0, 6166.0, 6184.752609895644, 6207.6275423474735, 9480.525973701288, 10005.599776009023, 10147.441890695934, 10173.54219060144, 10189.949050254701, 9859.852102218472, 10024.649137280307, 10037.247206459544, 10042.397456152654, 10057.295989280827, 7684.654190561439, 7801.570913599807, 7820.843583128306, 7828.765137045898, 7833.843323133506, 7617.733379331697, 7682.923170768444, 7691.230876912264, 7705.768826935201, 7763.961180194063, 8762.912370876209, 8811.030786613339, 8932.732018039469, 9000.414973026733, 9079.68221112258, 8990.775230619025, 9255.722328330161, 9289.953550232205, 9297.67458138962, 9302.906970930204, 6982.6159561222585, 7047.1895731989425, 7052.33002864727, 7060.364567188978, 7080.716771329296, 7366.226546212785, 7661.042369703787, 7695.538267703956, 8109.432339736162, 8130.552819594979, 6476.4495017924, 7250.89123663156, 7397.630118494161, 7439.479236453396, 7539.208383119693, 6948.444124469929, 7730.884036739566, 7743.728969486041, 7746.186650401852, 7833.060032796101, 7616.0860696716745, 7663.463557550918, 7664.578448185403, 7669.69321227167, 7687.461877668733, 6954.408875245661, 7028.648567571703, 7054.8236294091, 7084.326988936043, 7096.467764917755, 7179.066721326194, 7228.349448549656, 7229.132504099542, 7240.239774823568, 7249.311315425026], "unit": "ms", "name": "mootools.html", "value": 4726.919018807369}, {"lowerIsBetter": false, "replicates": [346.34886413542534, 350.14564462711, 355.4330842306522, 359.9532060832091, 364.5006341312401, 6139.72371243294, 6166.4450199482035, 6186.2885768136675, 6186.56694031418, 6198.163247961524, 5830.271216097988, 5919.691320385043, 5988.880222395549, 6101.054336577827, 6103.7253323600435, 4677.199278277871, 4695.999999999992, 4712.0, 4720.858374248778, 4728.290756386536, 4697.201475749113, 4700.3889494365685, 4703.788329525162, 4705.3177289293035, 4717.551832575899, 4511.548845115495, 4551.772411379435, 4599.632029437654, 4626.467956185032, 4659.720416774988, 4619.468761092467, 4632.953670463319, 4641.791119399635, 4661.603763680091, 4673.813047478096, 4080.2859499587453, 4082.856800095978, 4084.2233628371755, 4091.8772436826944, 4097.016715988141, 5796.623219490762, 5801.361850196475, 5803.303603567557, 5803.912941305884, 5804.245448091763, 5298.046351656701, 5449.782008719647, 5464.808731694411, 5466.262054622614, 5466.562674985991, 6455.677216139175, 6460.773872914472, 6472.805815825533, 6478.676066196718, 6480.4491618212505, 4572.222722137245, 4578.175928332898, 4579.061292435043, 4580.831887868606, 4583.931241031387, 6658.866822663568, 6731.730730770812, 6769.120014398097, 6791.592504449749, 6807.625580593065, 4701.19004183385, 4701.858944231679, 4702.764861756967, 4702.788374523155, 4711.858644240679, 4771.093492236464, 4772.188727916193, 4776.832810851603, 4779.928301075417, 4784.521547845187, 5463.3717122530625, 5466.125419932871, 5466.480684334982, 5476.315460567429, 5477.561795056386, 6401.55189136756, 6545.738170473223, 6548.27968923418, 6559.147310849559, 6561.671916404161, 1689.518487231158, 1715.322447633178, 1715.5882588178747, 1715.836995485427, 1719.2779032806002, 1173.747644256489, 1177.252444697606, 1182.6511179202157, 1203.8314635950974, 1204.753025629744, 6343.936560634427, 6351.2696039956, 6357.841053973688, 6361.173047503888, 6363.9045414318825, 6728.226253980757, 6730.0, 6737.258901520829, 6737.393634572912, 6740.797776066725, 6115.4801841843055, 6212.409821066992, 6268.341824108494, 6357.904631430532, 6358.078078678565, 3639.94540081899, 3654.154651900773, 3673.8530458781884, 3678.5217921670546, 3687.6312368763447, 6976.686049127801, 6990.26602206761, 6997.0, 7004.4396448284015, 7006.754763583352, 6762.526623136333, 6909.309069093151, 6924.3421874921805, 6938.5836849789175, 6948.062011628466, 6932.23745388007, 6937.618430986243, 6939.653017349112, 6949.3745562899585, 7003.334683204986, 6814.897776533455, 6819.283975182534, 6826.0, 6827.146606674166, 6828.0440738297675, 6524.967375163284, 6712.865742685021, 6741.089952856498, 6741.325867413416, 6746.527743057939, 7016.122984626922, 7030.964845175741, 7032.613206273704, 7035.0, 7044.753433630003, 4646.256598944153, 4691.085238378483, 4691.460482044472, 4693.413323334583, 4694.577488026094, 6699.229588597374, 6798.184217893884, 6816.795496135124, 6817.590944543145, 6824.761133360308, 6611.438027767694, 6616.735330586723, 6619.172603424572, 6624.701888414937, 6625.105610742681, 6478.28738838718, 6587.0, 6597.472202223715, 6600.1089852869245, 6601.438877695257, 6484.221893372825, 6501.024846272908, 6507.869842603027, 6514.771982980573, 6519.641419721961, 6630.30381809903, 6632.038354438483, 6635.900461493178, 6637.535372523877, 6643.867122657423, 6356.77751278703, 6437.356264373525, 6449.903251451326, 6450.451711604566, 6493.383128602775], "unit": "ms", "name": "prototype.html", "value": 4956.655820794999}, {"lowerIsBetter": false, "replicates": [843.4053991935685, 852.9658813647452, 887.4010043220825, 907.1019690506398, 963.4412041016211, 14811.703765924689, 14982.775258371134, 15087.471938482155, 15090.39638414465, 15092.773608395883, 13941.512047078355, 14097.506587269447, 14102.576922692335, 14112.43550257991, 14114.364853581588, 756.7011030642893, 768.6809973860841, 898.8831451911242, 910.5356268303146, 934.0799312677008, 913.7304495173906, 915.6062892956027, 921.9262459003263, 922.2483675804232, 922.4419226368051, 787.9842403151933, 976.1507488484992, 977.0669011094424, 977.5796407544752, 977.9657711980082, 791.6477167660394, 793.9801504962364, 940.2149205413454, 948.6964171465133, 949.2026697574071, 707.6992278281762, 710.7796583059268, 712.3624356201223, 713.414999700246, 714.5748279773527, 14391.2084835334, 14424.855751442456, 14513.129212247299, 14559.0, 14567.635809104751, 12772.297523636196, 12923.353832308441, 13318.467261309535, 13330.400131993987, 13363.293507419157, 11320.716982075432, 11379.943100284529, 11422.200445968785, 11448.370339631318, 11482.942585287105, 3886.3198940185353, 3956.3076461619103, 3960.5445373782095, 3968.1865217630316, 3968.3650615901315, 47902.0, 47996.520034799905, 48221.517784822056, 48948.0, 48982.51017489851, 10279.94860025695, 10337.9483102584, 10419.739506512398, 10554.894451055545, 10706.571737130427, 18483.0, 18495.630087398178, 18510.629787404447, 18529.258829646933, 18549.721754173697, 8107.1892810718455, 8208.507489550646, 8414.158584141536, 8525.914740852637, 8723.738287851374, 4800.279958006257, 4929.876753081202, 4993.350864387607, 5020.196768517019, 5051.191809310492, 3184.9363012739614, 3200.455922493182, 3202.215457212951, 3210.9036728898172, 3211.582494275776, 556.8385168301147, 570.4096260370496, 574.9827505174768, 576.1501784867371, 584.0742423259097, 642.6208536963214, 682.0144890632988, 696.5054811084187, 700.551646945955, 708.4757279613152, 9011.459312441144, 9134.177923986741, 9141.725748227564, 9188.26493880488, 9241.861372079424, 614.2322097378277, 672.7880717573948, 679.4292794053019, 708.4084789201074, 728.0717085715755, 4339.284018136972, 4350.195213885441, 4395.802188901507, 4407.933880991788, 4549.9990002199465, 59102.40897591055, 59374.70312648409, 59421.40578594245, 59434.40565594375, 59680.10479842806, 50279.0, 50593.74703126461, 51375.37621614073, 51399.48600514022, 53161.468385316424, 45796.3130553042, 45796.54203457989, 46368.536314637095, 46615.0, 48115.75942120267, 8996.55017249148, 9114.361994660576, 9276.860847087433, 9308.627654893728, 9414.985835552283, 35740.46389304214, 36409.089772754836, 36645.26709465849, 36668.63331366759, 36719.449208261365, 41858.37212441755, 47700.522994769606, 48148.759256204896, 48258.0, 48258.758706206245, 10576.682699519026, 10947.616833410792, 11316.15128865322, 11367.317960922372, 11454.370009649549, 12250.0, 12615.283595156787, 12741.299228542148, 13057.869421306046, 13092.410841511964, 11750.29498230109, 11781.882181178078, 11812.70468238301, 12038.75922481528, 12282.754344912873, 12269.93865030669, 12455.439505222468, 12465.750684986431, 12797.488100475877, 13014.089013769324, 11382.430878455878, 11521.711957201138, 11764.235324703866, 11968.640940771791, 12054.216475929037, 10442.843357349493, 10888.128949684165, 11045.83431248548, 11056.391898445663, 11525.711857203636, 9633.0, 9767.120959113714, 9861.161801246973, 9887.752806179904, 9947.900520994697], "unit": "ms", "name": "yui.html", "value": 6721.727815571125}], "name": "dromaeo_css", "value": 7518.863761122131}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 104.0, 109.0, 111.0, 109.0, 98.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [146.0, 130.0, 158.0, 164.0, 121.0, 149.0, 159.0, 122.0, 161.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 164.0, 159.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 152.0, 71.0, 72.0, 73.0, 73.0, 153.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 92.0, 92.0, 92.0, 138.0, 92.0, 92.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 57.0, 56.0, 60.0, 56.0, 56.0, 56.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 76.0, 76.0, 78.0, 77.0, 79.0, 77.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.2}, {"lowerIsBetter": true, "replicates": [119.0, 112.0, 115.0, 111.0, 118.0, 109.0, 126.0, 119.0, 108.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [130.0, 144.0, 139.0, 138.0, 138.0, 137.0, 141.0, 140.0, 142.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [65.0, 61.0, 64.0, 64.0, 64.0, 62.0, 63.0, 64.0, 63.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.6}], "name": "kraken", "value": 1470.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.37851490149856], "unit": "score", "name": "Richards", "value": 209.65857799999998}, {"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "DeltaBlue", "value": 400.6750800000002}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [965.2509652509652], "unit": "score", "name": "RayTrace", "value": 766.6286040000001}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [10536.842105263158], "unit": "score", "name": "Boyer", "value": 63.25073426573423}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [492.4205378973105], "unit": "score", "name": "Splay", "value": 165.49066037735847}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23156.47731985754}]} 02:30:56 INFO - RETURN: dromaeo_css: 7518.86 02:30:56 INFO - RETURN: kraken: 1470.60 02:30:56 INFO - RETURN: v8_7: 23156.48 02:30:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23156.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7518.86"}}} 02:30:56 INFO - Return code: 0 02:30:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:30:56 INFO - # TBPL SUCCESS # 02:30:56 INFO - Running post-action listener: _resource_record_post_action 02:30:56 INFO - Running post-run listener: _resource_record_post_run 02:30:57 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 516829184; Read time: 0; Write time: 422720 02:30:57 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 253276160; Read time: 0; Write time: 289752 02:30:57 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 263553024; Read time: 0; Write time: 132968 02:30:57 INFO - Running post-run listener: _upload_blobber_files 02:30:57 INFO - Blob upload gear active. 02:30:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:30:57 INFO - Copying logs to upload dir... 02:30:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.510703 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-04 02:30:57.304662) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:30:57.307796) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009928 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454571685/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:30:57.359667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:30:57.360003) ========= 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=8887e36bb8e381bfd44124ac000001a8-1454580514.345662-1712752109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004679 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:30:57.409335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 02:30:57.409647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 02:30:57.409960) ========= ========= Total master_lag: 0.46 =========