builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1456425796.87 results: success (0) buildid: 20160225083526 builduid: 2ddc80a5d2f7496fac05888c2cf94ef6 revision: 7f1106d85767 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.865606) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.866054) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.866401) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009105 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.889809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.890125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.903736) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.904039) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.954369) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.954696) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.955099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:16.955427) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 10:43:17-- 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% 229M=0s 2016-02-25 10:43:17 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170172 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.137949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.138309) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.189989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.190353) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7f1106d85767 --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 7f1106d85767 --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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 10:43:17,361 Setting DEBUG logging. 2016-02-25 10:43:17,361 attempt 1/10 2016-02-25 10:43:17,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7f1106d85767?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 10:43:17,643 unpacking tar archive at: mozilla-beta-7f1106d85767/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.795413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.795757) ========= echo 7f1106d85767 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7f1106d85767'] 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7f1106d85767 program finished with exit code 0 elapsedTime=0.003554 script_repo_revision: '7f1106d85767' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.843875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.844191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 10:43:17.854387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-25 10:43:17.854711) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:43:18 INFO - MultiFileLogger online at 20160225 10:43:18 in /builds/slave/test-pgo 10:43:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:43:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:43:18 INFO - {'append_to_log': False, 10:43:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:43:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:43:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:43:18 INFO - 'branch': 'Mozilla-Beta', 10:43:18 INFO - 'buildbot_json_path': 'buildprops.json', 10:43:18 INFO - 'config_files': ('talos/linux_config.py',), 10:43:18 INFO - 'default_actions': ('clobber', 10:43:18 INFO - 'read-buildbot-config', 10:43:18 INFO - 'download-and-extract', 10:43:18 INFO - 'populate-webroot', 10:43:18 INFO - 'create-virtualenv', 10:43:18 INFO - 'install', 10:43:18 INFO - 'run-tests'), 10:43:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:43:18 INFO - 'download_minidump_stackwalk': True, 10:43:18 INFO - 'download_symbols': 'ondemand', 10:43:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:43:18 INFO - 'tooltool.py': '/tools/tooltool.py', 10:43:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:43:18 INFO - '/tools/misc-python/virtualenv.py')}, 10:43:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:43:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:43:18 INFO - 'installer_path': 'installer.exe', 10:43:18 INFO - 'log_level': 'info', 10:43:18 INFO - 'log_name': 'talos', 10:43:18 INFO - 'log_to_console': True, 10:43:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:43:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:43:18 INFO - 'opt_config_files': (), 10:43:18 INFO - 'pip_index': False, 10:43:18 INFO - 'sps_profile': False, 10:43:18 INFO - 'sps_profile_interval': 0, 10:43:18 INFO - 'suite': 'dromaeojs', 10:43:18 INFO - 'system_bits': '32', 10:43:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:43:18 INFO - 'title': 'talos-linux64-ix-068', 10:43:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:43:18 INFO - 'use_talos_json': True, 10:43:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:43:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:43:18 INFO - 'work_dir': 'build'} 10:43:18 INFO - ##### 10:43:18 INFO - ##### Running clobber step. 10:43:18 INFO - ##### 10:43:18 INFO - Running pre-action listener: _resource_record_pre_action 10:43:18 INFO - Running main action method: clobber 10:43:18 INFO - rmtree: /builds/slave/test-pgo/build 10:43:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:43:18 INFO - Running post-action listener: _resource_record_post_action 10:43:18 INFO - ##### 10:43:18 INFO - ##### Running read-buildbot-config step. 10:43:18 INFO - ##### 10:43:18 INFO - Running pre-action listener: _resource_record_pre_action 10:43:18 INFO - Running main action method: read_buildbot_config 10:43:18 INFO - Using buildbot properties: 10:43:18 INFO - { 10:43:18 INFO - "properties": { 10:43:18 INFO - "buildnumber": 101, 10:43:18 INFO - "product": "firefox", 10:43:18 INFO - "script_repo_revision": "production", 10:43:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:43:18 INFO - "repository": "", 10:43:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:43:18 INFO - "buildid": "20160225083526", 10:43:18 INFO - "slavename": "talos-linux64-ix-068", 10:43:18 INFO - "pgo_build": "True", 10:43:18 INFO - "basedir": "/builds/slave/test-pgo", 10:43:18 INFO - "project": "", 10:43:18 INFO - "platform": "ubuntu64_hw", 10:43:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:43:18 INFO - "slavebuilddir": "test", 10:43:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:43:18 INFO - "branch": "mozilla-beta", 10:43:18 INFO - "repo_path": "releases/mozilla-beta", 10:43:18 INFO - "stage_platform": "linux64-pgo", 10:43:18 INFO - "builduid": "2ddc80a5d2f7496fac05888c2cf94ef6", 10:43:18 INFO - "revision": "7f1106d85767" 10:43:18 INFO - }, 10:43:18 INFO - "sourcestamp": { 10:43:18 INFO - "repository": "", 10:43:18 INFO - "hasPatch": false, 10:43:18 INFO - "project": "", 10:43:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:43:18 INFO - "changes": [ 10:43:18 INFO - { 10:43:18 INFO - "category": null, 10:43:18 INFO - "files": [ 10:43:18 INFO - { 10:43:18 INFO - "url": null, 10:43:18 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:43:18 INFO - } 10:43:18 INFO - ], 10:43:18 INFO - "repository": "", 10:43:18 INFO - "rev": "7f1106d85767", 10:43:18 INFO - "who": "sendchange", 10:43:18 INFO - "when": 1456425744, 10:43:18 INFO - "number": 7654345, 10:43:18 INFO - "comments": "Bug 1250488 - Fix Hello UITour window size + show _=45 users FTU again. r=Standard8,a=sledu", 10:43:18 INFO - "project": "", 10:43:18 INFO - "at": "Thu 25 Feb 2016 10:42:24", 10:43:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:43:18 INFO - "revlink": "", 10:43:18 INFO - "properties": [ 10:43:18 INFO - [ 10:43:18 INFO - "buildid", 10:43:18 INFO - "20160225083526", 10:43:18 INFO - "Change" 10:43:18 INFO - ], 10:43:18 INFO - [ 10:43:18 INFO - "builduid", 10:43:18 INFO - "2ddc80a5d2f7496fac05888c2cf94ef6", 10:43:18 INFO - "Change" 10:43:18 INFO - ], 10:43:18 INFO - [ 10:43:18 INFO - "pgo_build", 10:43:18 INFO - "True", 10:43:18 INFO - "Change" 10:43:18 INFO - ] 10:43:18 INFO - ], 10:43:18 INFO - "revision": "7f1106d85767" 10:43:18 INFO - } 10:43:18 INFO - ], 10:43:18 INFO - "revision": "7f1106d85767" 10:43:18 INFO - } 10:43:18 INFO - } 10:43:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:43:18 INFO - Running post-action listener: _resource_record_post_action 10:43:18 INFO - ##### 10:43:18 INFO - ##### Running download-and-extract step. 10:43:18 INFO - ##### 10:43:18 INFO - Running pre-action listener: _resource_record_pre_action 10:43:18 INFO - Running main action method: download_and_extract 10:43:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:43: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')]} 10:43:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/test_packages.json 10:43:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:43:18 INFO - Downloaded 1270 bytes. 10:43:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:43:18 INFO - Using the following test package requirements: 10:43:18 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:18 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:43:18 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'jsshell-linux-x86_64.zip'], 10:43:18 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:43:18 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:18 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:43:18 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:43:18 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:43:18 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:18 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:18 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:43:18 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:43: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')]} 10:43:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:43:19 INFO - Downloaded 21584184 bytes. 10:43:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:43:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:43:20 INFO - Return code: 0 10:43:20 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:43:20 INFO - Downloaded 21584184 bytes. 10:43:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:43:21 INFO - Return code: 0 10:43: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')]} 10:43:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:43:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:43:26 INFO - Downloaded 11132038 bytes. 10:43:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:43:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:43:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:43:26 INFO - Return code: 0 10:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:43:27 INFO - Downloaded 57949302 bytes. 10:43:27 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:27 INFO - mkdir: /builds/slave/test-pgo/properties 10:43:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:43:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:43:27 INFO - Contents: 10:43:27 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:27 INFO - Running post-action listener: _resource_record_post_action 10:43:27 INFO - Running post-action listener: set_extra_try_arguments 10:43:27 INFO - ##### 10:43:27 INFO - ##### Running populate-webroot step. 10:43:27 INFO - ##### 10:43:27 INFO - Running pre-action listener: _resource_record_pre_action 10:43:27 INFO - Running main action method: populate_webroot 10:43:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:43:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:43:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:43:27 INFO - '--tppagecycles', 10:43:27 INFO - '7'], 10:43:27 INFO - 'tests': ['tsvgm']}}, 10:43:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:43:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:43:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:43:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:43:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'tests': ['damp', 'tps']}, 10:43:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['damp', 'tps']}, 10:43:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:43:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:43:27 INFO - 'other': {'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'other_l64': {'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'other_nol64': {'tests': ['a11yr', 10:43:27 INFO - 'ts_paint', 10:43:27 INFO - 'tpaint', 10:43:27 INFO - 'sessionrestore', 10:43:27 INFO - 'sessionrestore_no_auto_restore']}, 10:43:27 INFO - 'svgr': {'tests': ['tsvgx', 10:43:27 INFO - 'tsvgr_opacity', 10:43:27 INFO - 'tart', 10:43:27 INFO - 'tscrollx', 10:43:27 INFO - 'cart']}, 10:43:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['tsvgx', 10:43:27 INFO - 'tsvgr_opacity', 10:43:27 INFO - 'tart', 10:43:27 INFO - 'tscrollx', 10:43:27 INFO - 'cart']}, 10:43:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'tests': ['tp5o']}, 10:43:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'talos_options': ['--e10s'], 10:43:27 INFO - 'tests': ['tp5o']}, 10:43:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'talos_options': ['--xperf_path', 10:43:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:27 INFO - 'tests': ['tp5n']}, 10:43:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:27 INFO - 'talos_options': ['--e10s', 10:43:27 INFO - '--xperf_path', 10:43:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:27 INFO - 'tests': ['tp5n']}}, 10:43:27 INFO - 'talos.zip': {'path': '', 10:43:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:43:27 INFO - Running post-action listener: _resource_record_post_action 10:43:27 INFO - ##### 10:43:27 INFO - ##### Running create-virtualenv step. 10:43:27 INFO - ##### 10:43:27 INFO - Running pre-action listener: _resource_record_pre_action 10:43:27 INFO - Running main action method: create_virtualenv 10:43:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:43:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:43:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:43:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:43:27 INFO - Using real prefix '/usr' 10:43:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:43:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:43:29 INFO - Installing pip.................done. 10:43:29 INFO - Return code: 0 10:43:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:43:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:43:29 INFO - Using env: {'DISPLAY': ':0', 10:43:29 INFO - 'HOME': '/home/cltbld', 10:43:29 INFO - 'LANG': 'en_US.UTF-8', 10:43:29 INFO - 'LANGUAGE': 'en_US:en', 10:43:29 INFO - 'LOGNAME': 'cltbld', 10:43:29 INFO - 'MAIL': '/var/mail/cltbld', 10:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:29 INFO - 'MOZ_NO_REMOTE': '1', 10:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:29 INFO - 'NO_EM_RESTART': '1', 10:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:29 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:29 INFO - 'SHELL': '/bin/bash', 10:43:29 INFO - 'SHLVL': '1', 10:43:29 INFO - 'TERM': 'linux', 10:43:29 INFO - 'TMOUT': '86400', 10:43:29 INFO - 'USER': 'cltbld', 10:43:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:29 INFO - '_': '/tools/buildbot/bin/python'} 10:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:43:30 INFO - Cleaning up... 10:43:30 INFO - Return code: 0 10:43:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:30 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:43:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:43:30 INFO - Using env: {'DISPLAY': ':0', 10:43:30 INFO - 'HOME': '/home/cltbld', 10:43:30 INFO - 'LANG': 'en_US.UTF-8', 10:43:30 INFO - 'LANGUAGE': 'en_US:en', 10:43:30 INFO - 'LOGNAME': 'cltbld', 10:43:30 INFO - 'MAIL': '/var/mail/cltbld', 10:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:30 INFO - 'MOZ_NO_REMOTE': '1', 10:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:30 INFO - 'NO_EM_RESTART': '1', 10:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:30 INFO - 'SHELL': '/bin/bash', 10:43:30 INFO - 'SHLVL': '1', 10:43:30 INFO - 'TERM': 'linux', 10:43:30 INFO - 'TMOUT': '86400', 10:43:30 INFO - 'USER': 'cltbld', 10:43:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:30 INFO - '_': '/tools/buildbot/bin/python'} 10:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:30 INFO - Downloading/unpacking psutil>=0.7.1 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:43:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:32 INFO - Installing collected packages: psutil 10:43:32 INFO - Running setup.py install for psutil 10:43:32 INFO - building 'psutil._psutil_linux' extension 10:43:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:43:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:43:32 INFO - building 'psutil._psutil_posix' extension 10:43:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:43:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:43:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:32 INFO - Successfully installed psutil 10:43:32 INFO - Cleaning up... 10:43:32 INFO - Return code: 0 10:43:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:43:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:43:32 INFO - Using env: {'DISPLAY': ':0', 10:43:32 INFO - 'HOME': '/home/cltbld', 10:43:32 INFO - 'LANG': 'en_US.UTF-8', 10:43:32 INFO - 'LANGUAGE': 'en_US:en', 10:43:32 INFO - 'LOGNAME': 'cltbld', 10:43:32 INFO - 'MAIL': '/var/mail/cltbld', 10:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:32 INFO - 'MOZ_NO_REMOTE': '1', 10:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:32 INFO - 'NO_EM_RESTART': '1', 10:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:32 INFO - 'SHELL': '/bin/bash', 10:43:32 INFO - 'SHLVL': '1', 10:43:32 INFO - 'TERM': 'linux', 10:43:32 INFO - 'TMOUT': '86400', 10:43:32 INFO - 'USER': 'cltbld', 10:43:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:32 INFO - '_': '/tools/buildbot/bin/python'} 10:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43: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 10:43:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:43:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:43:34 INFO - Installing collected packages: mozsystemmonitor 10:43:34 INFO - Running setup.py install for mozsystemmonitor 10:43:35 INFO - Successfully installed mozsystemmonitor 10:43:35 INFO - Cleaning up... 10:43:35 INFO - Return code: 0 10:43:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:35 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:43:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:43:35 INFO - Using env: {'DISPLAY': ':0', 10:43:35 INFO - 'HOME': '/home/cltbld', 10:43:35 INFO - 'LANG': 'en_US.UTF-8', 10:43:35 INFO - 'LANGUAGE': 'en_US:en', 10:43:35 INFO - 'LOGNAME': 'cltbld', 10:43:35 INFO - 'MAIL': '/var/mail/cltbld', 10:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:35 INFO - 'MOZ_NO_REMOTE': '1', 10:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:35 INFO - 'NO_EM_RESTART': '1', 10:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:35 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:35 INFO - 'SHELL': '/bin/bash', 10:43:35 INFO - 'SHLVL': '1', 10:43:35 INFO - 'TERM': 'linux', 10:43:35 INFO - 'TMOUT': '86400', 10:43:35 INFO - 'USER': 'cltbld', 10:43:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:35 INFO - '_': '/tools/buildbot/bin/python'} 10:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:35 INFO - Downloading/unpacking blobuploader==1.2.4 10:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:43:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:43:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:43:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:37 INFO - Downloading docopt-0.6.1.tar.gz 10:43:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:43:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:43:37 INFO - Running setup.py install for blobuploader 10:43:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:43:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:43:38 INFO - Running setup.py install for requests 10:43:38 INFO - Running setup.py install for docopt 10:43:38 INFO - Successfully installed blobuploader requests docopt 10:43:38 INFO - Cleaning up... 10:43:38 INFO - Return code: 0 10:43:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:38 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:43:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:43:38 INFO - Using env: {'DISPLAY': ':0', 10:43:38 INFO - 'HOME': '/home/cltbld', 10:43:38 INFO - 'LANG': 'en_US.UTF-8', 10:43:38 INFO - 'LANGUAGE': 'en_US:en', 10:43:38 INFO - 'LOGNAME': 'cltbld', 10:43:38 INFO - 'MAIL': '/var/mail/cltbld', 10:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:38 INFO - 'MOZ_NO_REMOTE': '1', 10:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:38 INFO - 'NO_EM_RESTART': '1', 10:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:38 INFO - 'SHELL': '/bin/bash', 10:43:38 INFO - 'SHLVL': '1', 10:43:38 INFO - 'TERM': 'linux', 10:43:38 INFO - 'TMOUT': '86400', 10:43:38 INFO - 'USER': 'cltbld', 10:43:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:38 INFO - '_': '/tools/buildbot/bin/python'} 10:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:38 INFO - Running setup.py (path:/tmp/pip-asmBt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:38 INFO - Running setup.py (path:/tmp/pip-6V5sKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:38 INFO - Running setup.py (path:/tmp/pip-YH4bso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:38 INFO - Running setup.py (path:/tmp/pip-9eHLVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:39 INFO - Running setup.py (path:/tmp/pip-6omi0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:39 INFO - Running setup.py (path:/tmp/pip-HI41WW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:39 INFO - Running setup.py (path:/tmp/pip-jyyBMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:39 INFO - Running setup.py (path:/tmp/pip-xGIfcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:39 INFO - Running setup.py (path:/tmp/pip-OTD4W6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:39 INFO - Running setup.py (path:/tmp/pip-wDqFIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:39 INFO - Running setup.py (path:/tmp/pip-GMderO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:39 INFO - Running setup.py (path:/tmp/pip-lgUCUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:39 INFO - Running setup.py (path:/tmp/pip-AllI0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:39 INFO - Running setup.py (path:/tmp/pip-Px_5CJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:39 INFO - Running setup.py (path:/tmp/pip-e3yv06-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:39 INFO - Running setup.py (path:/tmp/pip-2358Bm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:39 INFO - Running setup.py (path:/tmp/pip-BVnADd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:43:39 INFO - Running setup.py install for manifestparser 10:43:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Running setup.py install for mozcrash 10:43:40 INFO - Running setup.py install for mozdebug 10:43:40 INFO - Running setup.py install for mozdevice 10:43:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Running setup.py install for mozfile 10:43:40 INFO - Running setup.py install for mozhttpd 10:43:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Running setup.py install for mozinfo 10:43:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Running setup.py install for mozInstall 10:43:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:43:40 INFO - Running setup.py install for mozleak 10:43:40 INFO - Running setup.py install for mozlog 10:43:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Running setup.py install for moznetwork 10:43:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Running setup.py install for mozprocess 10:43:41 INFO - Running setup.py install for mozprofile 10:43:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Running setup.py install for mozrunner 10:43:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Running setup.py install for mozscreenshot 10:43:41 INFO - Running setup.py install for moztest 10:43:41 INFO - Running setup.py install for mozversion 10:43:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:43:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:43:41 INFO - Cleaning up... 10:43:41 INFO - Return code: 0 10:43:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:41 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:43:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:43:41 INFO - Using env: {'DISPLAY': ':0', 10:43:41 INFO - 'HOME': '/home/cltbld', 10:43:41 INFO - 'LANG': 'en_US.UTF-8', 10:43:41 INFO - 'LANGUAGE': 'en_US:en', 10:43:41 INFO - 'LOGNAME': 'cltbld', 10:43:41 INFO - 'MAIL': '/var/mail/cltbld', 10:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:41 INFO - 'MOZ_NO_REMOTE': '1', 10:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:41 INFO - 'NO_EM_RESTART': '1', 10:43:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:41 INFO - 'SHELL': '/bin/bash', 10:43:41 INFO - 'SHLVL': '1', 10:43:41 INFO - 'TERM': 'linux', 10:43:41 INFO - 'TMOUT': '86400', 10:43:41 INFO - 'USER': 'cltbld', 10:43:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:41 INFO - '_': '/tools/buildbot/bin/python'} 10:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:41 INFO - Running setup.py (path:/tmp/pip-XuEPdJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:42 INFO - Running setup.py (path:/tmp/pip-9wHmC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:42 INFO - Running setup.py (path:/tmp/pip-C3Ec8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:42 INFO - Running setup.py (path:/tmp/pip-rQtmlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:42 INFO - Running setup.py (path:/tmp/pip-8Gn0Ba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:42 INFO - Running setup.py (path:/tmp/pip-Eg13yO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:42 INFO - Running setup.py (path:/tmp/pip-aKVtvq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:42 INFO - Running setup.py (path:/tmp/pip-G34KvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:42 INFO - Running setup.py (path:/tmp/pip-_vb3eQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:42 INFO - Running setup.py (path:/tmp/pip-hSeJqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:42 INFO - Running setup.py (path:/tmp/pip-goLGWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:42 INFO - Running setup.py (path:/tmp/pip-JG15I0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:42 INFO - Running setup.py (path:/tmp/pip-TwfTam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:43:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:42 INFO - Running setup.py (path:/tmp/pip-qPnISI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:43:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:43 INFO - Running setup.py (path:/tmp/pip-zkTxGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:43:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:43 INFO - Running setup.py (path:/tmp/pip-arJw7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:43:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:43 INFO - Running setup.py (path:/tmp/pip-CgMPkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:43:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:43:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - Downloading blessings-1.6.tar.gz 10:43:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:43:45 INFO - Installing collected packages: blessings 10:43:45 INFO - Running setup.py install for blessings 10:43:45 INFO - Successfully installed blessings 10:43:45 INFO - Cleaning up... 10:43:45 INFO - Return code: 0 10:43:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:43:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:43:45 INFO - Reading from file tmpfile_stdout 10:43:45 INFO - Current package versions: 10:43:45 INFO - argparse == 1.2.1 10:43:45 INFO - blessings == 1.6 10:43:45 INFO - blobuploader == 1.2.4 10:43:45 INFO - docopt == 0.6.1 10:43:45 INFO - manifestparser == 1.1 10:43:45 INFO - mozInstall == 1.12 10:43:45 INFO - mozcrash == 0.16 10:43:45 INFO - mozdebug == 0.1 10:43:45 INFO - mozdevice == 0.47 10:43:45 INFO - mozfile == 1.2 10:43:45 INFO - mozhttpd == 0.7 10:43:45 INFO - mozinfo == 0.9 10:43:45 INFO - mozleak == 0.1 10:43:45 INFO - mozlog == 3.1 10:43:45 INFO - moznetwork == 0.27 10:43:45 INFO - mozprocess == 0.22 10:43:45 INFO - mozprofile == 0.27 10:43:45 INFO - mozrunner == 6.11 10:43:45 INFO - mozscreenshot == 0.1 10:43:45 INFO - mozsystemmonitor == 0.0 10:43:45 INFO - moztest == 0.7 10:43:45 INFO - mozversion == 1.4 10:43:45 INFO - psutil == 3.1.1 10:43:45 INFO - requests == 1.2.3 10:43:45 INFO - wsgiref == 0.1.2 10:43:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:45 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:43:45 INFO - Using env: {'DISPLAY': ':0', 10:43:45 INFO - 'HOME': '/home/cltbld', 10:43:45 INFO - 'LANG': 'en_US.UTF-8', 10:43:45 INFO - 'LANGUAGE': 'en_US:en', 10:43:45 INFO - 'LOGNAME': 'cltbld', 10:43:45 INFO - 'MAIL': '/var/mail/cltbld', 10:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:45 INFO - 'MOZ_NO_REMOTE': '1', 10:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:45 INFO - 'NO_EM_RESTART': '1', 10:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:45 INFO - 'SHELL': '/bin/bash', 10:43:45 INFO - 'SHLVL': '1', 10:43:45 INFO - 'TERM': 'linux', 10:43:45 INFO - 'TMOUT': '86400', 10:43:45 INFO - 'USER': 'cltbld', 10:43:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:45 INFO - '_': '/tools/buildbot/bin/python'} 10:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:43:45 INFO - Cleaning up... 10:43:45 INFO - Return code: 0 10:43:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:45 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 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:43:45 INFO - Using env: {'DISPLAY': ':0', 10:43:45 INFO - 'HOME': '/home/cltbld', 10:43:45 INFO - 'LANG': 'en_US.UTF-8', 10:43:45 INFO - 'LANGUAGE': 'en_US:en', 10:43:45 INFO - 'LOGNAME': 'cltbld', 10:43:45 INFO - 'MAIL': '/var/mail/cltbld', 10:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:45 INFO - 'MOZ_NO_REMOTE': '1', 10:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:45 INFO - 'NO_EM_RESTART': '1', 10:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:45 INFO - 'SHELL': '/bin/bash', 10:43:45 INFO - 'SHLVL': '1', 10:43:45 INFO - 'TERM': 'linux', 10:43:45 INFO - 'TMOUT': '86400', 10:43:45 INFO - 'USER': 'cltbld', 10:43:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:45 INFO - '_': '/tools/buildbot/bin/python'} 10:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:45 INFO - Downloading/unpacking jsonschema 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:43:47 INFO - Downloading/unpacking functools32 (from jsonschema) 10:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:43:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:43:48 INFO - warning: no files found matching '*.txt' 10:43:48 INFO - no previously-included directories found matching 'build' 10:43:48 INFO - no previously-included directories found matching 'dist' 10:43:48 INFO - no previously-included directories found matching '.git*' 10:43:48 INFO - Installing collected packages: jsonschema, functools32 10:43:48 INFO - Running setup.py install for functools32 10:43:48 INFO - warning: no files found matching '*.txt' 10:43:48 INFO - no previously-included directories found matching 'build' 10:43:48 INFO - no previously-included directories found matching 'dist' 10:43:48 INFO - no previously-included directories found matching '.git*' 10:43:48 INFO - Successfully installed jsonschema functools32 10:43:48 INFO - Cleaning up... 10:43:48 INFO - Return code: 0 10:43:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e2d6fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x190a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:43:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:43:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:43:48 INFO - Using env: {'DISPLAY': ':0', 10:43:48 INFO - 'HOME': '/home/cltbld', 10:43:48 INFO - 'LANG': 'en_US.UTF-8', 10:43:48 INFO - 'LANGUAGE': 'en_US:en', 10:43:48 INFO - 'LOGNAME': 'cltbld', 10:43:48 INFO - 'MAIL': '/var/mail/cltbld', 10:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:48 INFO - 'MOZ_NO_REMOTE': '1', 10:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:48 INFO - 'NO_EM_RESTART': '1', 10:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:48 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:48 INFO - 'SHELL': '/bin/bash', 10:43:48 INFO - 'SHLVL': '1', 10:43:48 INFO - 'TERM': 'linux', 10:43:48 INFO - 'TMOUT': '86400', 10:43:48 INFO - 'USER': 'cltbld', 10:43:48 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:48 INFO - '_': '/tools/buildbot/bin/python'} 10:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:48 INFO - Downloading/unpacking flake8 10:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:43:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:43:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:43:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:43:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:43:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:43:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:43:50 INFO - no previously-included directories found matching 'docs/_build' 10:43:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:43:51 INFO - Running setup.py install for pep8 10:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:43:51 INFO - no previously-included directories found matching 'docs/_build' 10:43:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:43:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:43:51 INFO - Cleaning up... 10:43:51 INFO - Return code: 0 10:43:51 INFO - Running post-action listener: _resource_record_post_action 10:43:51 INFO - Running post-action listener: _start_resource_monitoring 10:43:51 INFO - Starting resource monitoring. 10:43:51 INFO - ##### 10:43:51 INFO - ##### Running install step. 10:43:51 INFO - ##### 10:43:51 INFO - Running pre-action listener: _resource_record_pre_action 10:43:51 INFO - Running main action method: install 10:43:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:43:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:43:51 INFO - Reading from file tmpfile_stdout 10:43:51 INFO - Detecting whether we're running mozinstall >=1.0... 10:43:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:43:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:43:51 INFO - Reading from file tmpfile_stdout 10:43:51 INFO - Output received: 10:43:51 INFO - Usage: mozinstall [options] installer 10:43:51 INFO - Options: 10:43:51 INFO - -h, --help show this help message and exit 10:43:51 INFO - -d DEST, --destination=DEST 10:43:51 INFO - Directory to install application into. [default: 10:43:51 INFO - "/builds/slave/test-pgo"] 10:43:51 INFO - --app=APP Application being installed. [default: firefox] 10:43:51 INFO - mkdir: /builds/slave/test-pgo/build/application 10:43:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:43:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:44:06 INFO - Reading from file tmpfile_stdout 10:44:06 INFO - Output received: 10:44:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:44:06 INFO - Running post-action listener: _resource_record_post_action 10:44:06 INFO - ##### 10:44:06 INFO - ##### Running run-tests step. 10:44:06 INFO - ##### 10:44:06 INFO - Running pre-action listener: _resource_record_pre_action 10:44:06 INFO - Running main action method: run_tests 10:44:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:44:06 INFO - Python 2.7.3 10:44:06 INFO - Return code: 0 10:44:06 INFO - grabbing minidump binary from tooltool 10:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:06 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 0x1999350>, '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 0x199a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:44:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:44:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:44:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:44:06 INFO - Return code: 0 10:44:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:44:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:44:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:44:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:44:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:44:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:44:07 INFO - Return code: 0 10:44:07 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/1456418126/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:44:07 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/1456418126/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 10:44:07 INFO - Using env: {'DISPLAY': ':0', 10:44:07 INFO - 'HOME': '/home/cltbld', 10:44:07 INFO - 'LANG': 'en_US.UTF-8', 10:44:07 INFO - 'LANGUAGE': 'en_US:en', 10:44:07 INFO - 'LOGNAME': 'cltbld', 10:44:07 INFO - 'MAIL': '/var/mail/cltbld', 10:44:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:44:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:07 INFO - 'MOZ_NO_REMOTE': '1', 10:44:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:07 INFO - 'NO_EM_RESTART': '1', 10:44:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:44:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:44:07 INFO - 'SHELL': '/bin/bash', 10:44:07 INFO - 'SHLVL': '1', 10:44:07 INFO - 'TERM': 'linux', 10:44:07 INFO - 'TMOUT': '86400', 10:44:07 INFO - 'USER': 'cltbld', 10:44:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796', 10:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:07 INFO - '_': '/tools/buildbot/bin/python'} 10:44:07 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/1456418126/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 10:44:07 INFO - mozversion INFO | application_buildid: 20160225083526 10:44:07 INFO - mozversion INFO | application_changeset: 7f1106d85767e19758c52ff5ebd5cdd28fcbb0d7 10:44:07 INFO - mozversion INFO | application_display_name: Nightly 10:44:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:44:07 INFO - mozversion INFO | application_name: Firefox 10:44:07 INFO - mozversion INFO | application_remotingname: firefox 10:44:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:44:07 INFO - mozversion INFO | application_vendor: Mozilla 10:44:07 INFO - mozversion INFO | application_version: 45.0 10:44:07 INFO - mozversion INFO | platform_buildid: 20160225083526 10:44:07 INFO - mozversion INFO | platform_changeset: 7f1106d85767e19758c52ff5ebd5cdd28fcbb0d7 10:44:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:44:07 INFO - mozversion INFO | platform_version: 45.0 10:44:07 INFO - 2016-02-25 10:44:07,442 DEBUG : using testdate: 1456425847 10:44:07 INFO - 2016-02-25 10:44:07,442 DEBUG : actual date: 1456425847 10:44:07 INFO - 2016-02-25 10:44:07,450 INFO : starting webserver on 'localhost:46293' 10:44:07 INFO - 2016-02-25 10:44:07,451 INFO : Starting test suite talos-linux64-ix-068 10:44:07 INFO - 2016-02-25 10:44:07,451 INFO : Starting test dromaeo_css 10:44:07 INFO - 2016-02-25 10:44:07,451 DEBUG : operating with platform_type : linux_ 10:44:07 INFO - 2016-02-25 10:44:07,452 INFO : Initialising browser for dromaeo_css test... 10:44:07 INFO - 2016-02-25 10:44:07,466 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHw4wwy/profile http://localhost:46293/getInfo.html 10:44:11 INFO - 2016-02-25 10:44:11,407 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:44:11 INFO - 2016-02-25 10:44:11,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:44:11 INFO - 2016-02-25 10:44:11,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:44:11 INFO - 2016-02-25 10:44:11,407 DEBUG : BROWSER_OUTPUT: __metrics 10:44:11 INFO - 2016-02-25 10:44:11,556 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:44:12 INFO - 2016-02-25 10:44:12,697 INFO : Browser initialized. 10:44:12 INFO - 2016-02-25 10:44:12,698 INFO : Running cycle 1/1 for dromaeo_css test... 10:44:12 INFO - 2016-02-25 10:44:12,698 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHw4wwy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:44:24 INFO - 2016-02-25 10:44:24,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 133873664 10:44:24 INFO - 2016-02-25 10:44:24,386 DEBUG : BROWSER_OUTPUT: 10:45:16 INFO - 2016-02-25 10:45:16,032 DEBUG : BROWSER_OUTPUT: 1456425916031 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:47:22 INFO - 2016-02-25 10:47:22,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46293/tests/dromaeo/cssquery-ext.html) 10:47:24 INFO - 2016-02-25 10:47:24,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 255008768 10:47:24 INFO - 2016-02-25 10:47:24,175 DEBUG : BROWSER_OUTPUT: 10:50:26 INFO - 2016-02-25 10:50:26,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-ext.html (next: http://localhost:46293/tests/dromaeo/cssquery-jquery.html) 10:50:26 INFO - 2016-02-25 10:50:26,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 217243648 10:50:26 INFO - 2016-02-25 10:50:26,785 DEBUG : BROWSER_OUTPUT: 10:53:28 INFO - 2016-02-25 10:53:28,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46293/tests/dromaeo/cssquery-mootools.html) 10:53:29 INFO - 2016-02-25 10:53:29,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 210853888 10:53:29 INFO - 2016-02-25 10:53:29,179 DEBUG : BROWSER_OUTPUT: 10:56:30 INFO - 2016-02-25 10:56:30,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46293/tests/dromaeo/cssquery-prototype.html) 10:56:31 INFO - 2016-02-25 10:56:31,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 198770688 10:56:31 INFO - 2016-02-25 10:56:31,390 DEBUG : BROWSER_OUTPUT: 10:59:33 INFO - 2016-02-25 10:59:33,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46293/tests/dromaeo/cssquery-yui.html) 10:59:34 INFO - 2016-02-25 10:59:34,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 199606272 10:59:34 INFO - 2016-02-25 10:59:34,396 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/dromaeo/cssquery-yui.html (next: http://localhost:46293/tests/dromaeo/cssquery-dojo.html) 11:02:36 INFO - 2016-02-25 11:02:36,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 242921472 11:02:36 INFO - 2016-02-25 11:02:36,859 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,859 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:02:36 INFO - 2016-02-25 11:02:36,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:02:36 INFO - 2016-02-25 11:02:36,859 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:02:36 INFO - 2016-02-25 11:02:36,860 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:02:36 INFO - 2016-02-25 11:02:36,863 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3179.60254968129;3310.9834450827743;3331.2005118771503;3343.8160901150427;3364.394409006378;5361.061814182517;5407.5133238008575;5409.459054094588;5429.294191755072;5439.129739241722;5414.160805075219;5419.051665958461;5422.864428389292;5453.809116680917;5454.318210223722;4819.975900120495;4920.065187614359;4940.5059494050665;4979.352684151056;4998.025385049917;4877.53663401978;4932.235503496946;4938.7530623468865;4941.827036053739;4944.307796908436;4896.706197628136;4951.207806750921;4962.751862406883;4982.252662100677;4999.60003199745;4964.429090654585;4973.477784832577;5092.79628814847;5097.184450487941;5099.3370861787735;4982.377202849644;4997.375328083989;5004.949950500485;5005.6996580205305;5030.2957585938;5134.794608215667;5166.302549155891;5212.8957420851375;5254.238135470336;5260.395054568736;5815.592908496407;5819.156222347736;5836.854078648025;5860.765569377262;5876.177335173079;5860.326062502824;5865.296164460292;5870.677112758796;5874.353821079678;5876.1479585459865;5236.083685355047;5329.440408757064;5389.676619402849;5397.865053373658;5509.146082357241;5884.646921184657;5912.438318359749;5914.319853216849;5922.555808314393;5932.169496270526;5720.485156335866;5722.141678748221;5722.4277572242445;5727.8854422912145;5727.971360143172;5673.801416950387;5688.345840228344;5781.19063331134;5781.508571771446;5798.5071268941765;5707.71461426927;5800.332961709373;5806.854828629318;5810.331811841608;5813.128030795415;5783.768649253982;5798.8550286242335;5810.564207684356;5828.242328497268;5828.562857785683;4408.933865992013;4415.62467190286;4445.5776701213335;4499.955000449953;4506.684532082722;3974.6621537169085;3976.7812770297332;3987.8205480753436;4006.3990401439432;4008.7995600219874;5263.26314315996;5482.369527504388;5483.972580137074;5484.957858006966;5494.532964697965;5609.8597535061135;5696.174054762037;5713.714314284269;5724.914126288109;5753.252077229933;5458.563314934796;5564.109742441271;5568.415316391802;5570.359408668055;5571.721413929287;4907.68100073494;4994.80020799164;5070.518300761421;5088.592912566985;5131.79472821083;5879.20630714848;5999.790007349722;6005.579609427386;6009.098635204667;6037.215162028908;5915.940840591625;5934.703264836828;5936.050231962865;5944.613600115978;5948.5538584605465;5838.299404071538;5892.734826932712;5939.049752039653;6032.215811944419;6049.909251361145;5764.6829424380385;5778.595498315246;5779.739911703899;5796.04365279741;5829.795957141479;5777.24895763548;5829.329627092939;5832.387599302182;5832.62087964281;5838.708064596668;5437.972810136082;5579.693116878449;5587.69267690281;5636.239107720569;5709.7430615623225;5558.138488534284;5619;5619.578531610064;5639.154126881001;5649.4633009864;5642.633228840113;5663.150527420919;5663.348714897839;5672.064109421899;5677;5400.081986062457;5523.337199536081;5656.745446455002;5767.163761254678;5780.21967034445;5608.130739735348;5617.691026993554;5618.831435056954;5625.8593535161945;5640.971795140998 11:02:36 INFO - 2016-02-25 11:02:36,863 DEBUG : BROWSER_OUTPUT: |1;ext.html;599.4095815621612;632.9746810127592;632.9873402531947;645.2418408370164;650.6226388694556;32405.837970810142;41458.585414145884;42048;42065.369019464735;42071.158576828486;45939.310910336375;46730.53269467304;46801.29798053023;46820.29769553451;46830.765846170805;8040.316573091265;8168.142345053773;8173.632186551619;9007.819843603123;9195;10767;11004.724881877977;11008.339499630009;11011.119110471183;11020.944895275512;10671.733206669856;10781.191410644233;10784.191185661068;10784.299020563678;10787.5684972601;10622.203334749925;10622.893771062269;10717.035466808025;10720.731981700443;10726.034656880918;10280.74298142545;10302.587896484132;10357.844632330522;10375.118114960238;10391.740206494822;42579.36130958038;43054;43062.56937430617;43063.13873722508;43071;3696.075981004749;3827.61723827615;3935.0162459385156;4276.23027854986;4334.718243314206;32347.353052939045;32554.511682324784;32570.348593028244;32684.019479415656;32765.83617081923;4331.328644060176;4410.448693913261;4440.866773996785;4443.977780111111;4499.820007199708;294390;297020;298609;298628;301224;63380.683096584224;63858.36141638617;64776.67611661911;64799.67600161969;64970.350296497374;63973.680131599045;64124.67937660282;64739;64781.67609161924;64784;16828.411005614744;17019.82980170207;17047.062411567236;17142.914285428742;17148.828511714724;12882.355882205853;13096.148750331198;13102.672433189247;13199.20804751718;13210.933945330213;21149.471263218235;21617.459563511038;21624.675629865564;21687.240946566795;21709.56580868374;7887.912296568796;8137.5931203439595;8164.142765009708;8212;8316.958415207886;1069.1072954083272;1071.223363061774;1087.260662749338;1094.4965315954591;1167.8598568171874;29568;29757.702422975926;30404.239894002825;30489;30565.847170764006;1126.189143816451;1132.841402203692;1150.3443037468562;1174.9647510574696;1200.6578125234266;13499.392527336293;14073.366698498592;14321.78517322241;14952.327145278488;16330.51008469724;259799;263108;263858;264155;264177;53800;54579.454205457434;54622.453775462534;54703.72648136813;54789;1474.7787831825312;1480.178500931993;1493.6415260337442;1495.2000679636342;1499.6475828180369;24920.626190606792;29490.82811579462;30006;30387.84806076044;30504;45610.54389456063;46106;46108;46121.76939115417;46125.76937115293;214414;216585;216975;217165;217246;33071.33857322888;33184;33570.16074598057;33584;33584.83207583946;44934;45289;45651.771741141085;46189.07621847611;46780.766096170664;37954.81022594869;38656.2268754629;38965.61034389733;38996.6100338993;39233.2153356937;37167.25665486621;38028.619713803615;38034.809825950695;38621.80689096537;38634.6136538631;37424.25151497009;37624.43563346607;37858.8107059474;37938.62061379351;38039.42940855834;33014.50478242876;33817;33885.32229355448;33920.805449093;34348.31303373868;26019.479610408063;26138;26210.213693589223;26358.604620931084;26687 11:02:36 INFO - 2016-02-25 11:02:36,863 DEBUG : BROWSER_OUTPUT: |2;jquery.html;378.0737193875007;381.88108841095595;383.2909118131457;383.34830787660985;392.47408472646646;15021.248937553133;16436.178191090443;17556.56108597286;17632.206550705218;17654.823451765493;17408.56478588036;17530.474085777416;17536.12319384029;18273.81726182738;18391.448256552325;5482.451754824526;5629.155626656014;5633.7183140843;5635.971820140914;5636.830895073133;4252.9787351063205;4361.672874534423;5657.405972372882;6005.699715014253;6184.81445556634;6068.059450785136;6176.073588961669;6202.379762023784;6232.252129744437;6264.686765661721;6142.539309551801;6151.630902145863;6155.322914479404;6162.7534898604;6166.445019948182;5138.460461651547;5470.234167216593;5472.644278121909;5476.2333273341765;5478.260434841325;14113.364898579588;14264.857351426457;14307.785383219156;18202.817971820376;21514.78485215159;2251.9774802252095;2273.6816845641624;2321.3152120124437;2324.697789287382;2367.6093444581625;10135.797284054352;10290.845637315446;10392;10460.476976151162;12201;1903.4860587641397;1924.2110734598748;1943.8833669979847;2013.345662659627;2014.5064459207588;56933;58203.708981455246;61566.384336156516;64209;64867;10641.946790266;11000.284981476178;11016.394098324668;11136.164787640959;11224.607138750105;14454.494092706705;14525.636859078397;14527.491537796337;14536.27318634064;14544.85455145435;7766.262205090507;7808.375329973588;7819.139894611588;8116.269535741693;8211.384146189059;7269.491135620561;7306.159791623925;7520.511166774142;7967.880481792662;7993.080795708568;4763.404574428197;4803.78382972767;4814.9518504815205;4821.566059054632;4836.46798852126;1718.7937447506379;1736.4773240922132;1807.7198034304704;1815.7185636226407;1816.554944038719;452.77587594140454;463.75884540039664;468.54082998661505;480.70917095157625;963.2390411574777;9962.701118966443;10525.789484210427;10928.508217130247;11115.55537778496;11788.646340609796;456.6597884576012;457.7711144427786;495.38819557846034;515.2966201135423;525.4823998361611;5453.945460545423;6472.093906853044;6589.80230593083;6607.14107166075;6728.226253980757;616339;616622;630811;635422;635442;83656;84672;85926.57036714777;88784.5560772192;89346;532;541.73996481689;541.9783208671688;542.3275138827825;542.533421257718;10557.472126393803;11188.776224475629;11244.718882028015;11306.773864522498;11314.15143864197;35708.64291357157;36151.63848361483;36274.8186259067;36727.08182295464;36794.632053680194;50259;50662;52312.47687523076;52753.153639622426;54170.18744718911;10245.282830201815;10275.897241027495;10439.530221139916;10566.313189642957;10566.788664226518;17327.91336043312;18101.637967240844;18348.81651183471;18650.253989840254;18748.15633296532;15119.092854428329;15292.617684557976;15325.386984520494;15492.225388730292;15651.608709782347;11379.886201138213;14805.925970370079;14848.703025939205;15495.767563486332;15679.216039198223;15142.621434464227;15356.46252381206;15372.846271537588;15466.5360039199;15583.76624350613;10117.342372745748;10499.475026248505;10618.8407173894;10619.097376723064;10693.9465302673;11256.493457794582;14593.197374144524;14853.554393368217;14992.925035374754;15140 11:02:36 INFO - 2016-02-25 11:02:36,864 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.3419529602268;1537.8692811111061;1725.8705597080223;1790.2659909437132;1833.211718960847;7662.195469475709;7879.40904432167;7881.605919704013;7891.250331218539;7892.6448309826055;7869.055713314396;7929.088154862193;7954.045514538249;7961.76114716558;7964.641591128398;2313;2321.965170522435;2343.4024323797494;2347.248880358286;2350.482893763378;2301.5972204864165;2330.5222429402015;2331.1491305673394;2332.941676458085;2333.9533209335805;2001.5596568754922;2040.5102775333887;2277.635578307471;2289.748127705951;2338.0530884991604;2301.436148143707;2323.6979192705007;2337.1002164166835;2340.3330050935488;2341.8594884306995;2280;2322.396176993977;2328.918487852934;2333;2334.6381310896836;6864.176298844171;7053.612051337174;7523.924760752432;7691.346235569983;7706.768796936045;4755.738434386108;4821.7589120543835;4838.298446725205;4840.177169881129;4842.66101372904;3114.859831307597;3127.687231276877;3132.0447263584597;3164.746820254374;3172.952405713893;1016.16166662503;1024.5440778853413;1036.4299635200684;1042.5152304178594;1055.6569115037644;10560.155187584975;10604.310719803188;10607.363558186456;10623.097036751808;10630.309029913109;4184.895377615584;4197.24449599069;4201.852935147255;4250.3199488081755;4279.33670281107;9173.44959302444;9177.541122943827;9182.90817091834;9184.954075229714;9189.81620367589;4651.62786977041;4688.5545873142;4690;4696.835610753607;4697.224957881979;4281.529031806499;4286.571342865688;4291.291936830388;4295.892602684896;4298.978505107454;3579.713622910161;3617.1680513482047;3641.7632853864416;3656.835442405098;3661.7436779425184;1128.368113856243;1130.5873356224918;1136.687126369045;1141.5890279499374;1152.1704372851534;1061.803566340214;1080.195254535376;1082.6697857153486;1275.5408053100875;1406.0157889477407;7504.212057733968;7582.734604288823;7605.277498637621;7645.503042302233;7650.8087297818;503.7380562107683;507.092304774457;507.53814029233223;510.4461659099844;522.3992408729991;5725.1698503716725;6019.638821670714;6072.453479186895;6088.726007329681;6096.207493025879;8739.606717697592;9408.247340212767;9449.811003779885;9452.669156579486;9466.526673666427;9065.41074830134;9136.908630913738;9278.768030799283;9285.628574857064;9507.239420846316;7329.74345897891;7338.4496162788;7407.592582407911;7410.221926697727;7414.110306763115;7443.144038435649;7489.8876516851205;7528.962355188189;7536.962315188389;7559.622018899143;8344.791380215544;8466.280366168945;8507.914920850711;8508.064112947446;8516.829663406574;8382.874256886029;8506.617202226038;8657.653693852175;8663.696770613251;8741.606627701896;7004.229534751275;7008;7068.858622827617;7070.893936590853;7083.1854336749875;7520.736774212876;7560.924390756242;7609.429292802951;7632.69469221225;7660.310572048543;7198;7240.637968101469;7257.891131633135;7321.341079302888;7333.1200255969625;6943.652817359213;6974.476914231352;7038.683259253448;7093.82265443368;7137.179224389054;7177.425805935617;7180.856382872209;7216.422686185198;7232.168300645493;7232.276772322725;6573.80278591643;6611.669416529058;6633.270340262471;6644.4020038196795;6645.501587380869;6645.335466453316;6670.299618540177;6679.966600166968;6683;6683.732650693918 11:02:36 INFO - 2016-02-25 11:02:36,865 DEBUG : BROWSER_OUTPUT: |4;prototype.html;372.4896891258975;377.6619925166976;377.69218087258884;380.6345907928389;387.2815926456423;5872.7944521941745;5990.10148477728;5995.550333724967;6034;6054.273487181539;5835.649861008332;5980.521558275327;5984.132300816379;6005.969970150154;6017.368176341487;4721.787519561611;4730.172219861528;4731.597814185799;4734.857954261361;4735.976320118394;4477.843275485358;4563.452385713703;4565.041341318327;4693.108309421199;4740.028294199681;4641.651876109288;4659.697119687226;4667.4632417272105;4680.5085466026085;4704.223803072506;4695.71825690458;4711.835085772016;4714.245720684708;4715.033418149288;4716.599089077433;4184.602462766033;4190.20386126635;4192.308269135589;4193.056562273495;4199.4120823084795;5649.350324712669;5742.08126699726;5748.798792042258;5754.712264386806;5763.366029736768;5483.862903427406;5486.61593688442;5487.64330318528;5489.451054894518;5495.065838807413;6113.633182009094;6363.109164716943;6366.045093236005;6369.904451433232;6369.9681501592195;4488.41650585425;4515.300128480091;4641.396618439581;4642.303654451825;4645.396098507173;6531.346865313478;6581.802545923582;6598.340165983412;6602.8349291268105;6608.570442921195;4750.857474275777;4753.5008824072975;4756.453007904066;4762.928556071662;4770.594499467584;4725.787339569728;4778.331033655291;4787.138315103245;4794.232922732346;4817.349657796152;5398.055340315429;5423.294971653739;5432.02223599748;5433.0763770159165;5436.157395603688;6336.651484168323;6369.235691717024;6378.808635740936;6383.202099737533;6383.202099737533;1696.5334533003277;1713.6487020160837;1714.0829656133908;1716.4421562992077;1717.4504158669106;1109.2955972957068;1115.1914861725347;1119.082352470966;1121.2991880074953;1151.573917650458;6203.410675985774;6207.224096987877;6210.875782484325;6239.625622462576;6246.562740608114;6515.283318834924;6555.508336874754;6567.244766851778;6567.408933196035;6575.112359831362;6056.697165141725;6134.957057300269;6135;6143.017117261216;6218.689065546704;3461.8442170102408;3552.1297282166033;3554.7156227501737;3562.7327950403824;3571.035820328497;6701.061851340816;6709.630970296681;6714.899276510856;6715.1941766988275;6720.731170753213;6697.397234248843;6704.161979752531;6704.59772413647;6706.765263215764;6707.664616769142;6558.967205163944;6656.0348749430095;6661.300563440769;6662.034005069335;6702.463802895757;6482.773102941374;6525.608463492205;6528.67356632176;6571.671416429255;6593.505487088583;6528.836779080561;6547.214334279917;6558.868822623616;6570.080188773671;6571.934280657132;6815.965920170367;6833.043373927555;6833.214180369321;6837.453003759588;6839.871421215444;4584.862454126382;4642.698224615389;4643.721376717408;4651.395318608559;4656.743879086547;6651.368120028589;6662.267150613526;6664.366885145903;6672.065910772592;6675.766348177791;6490.253620833476;6510.990796426561;6511.251206111168;6513.54405191632;6516.5112616553;6264.5614806964895;6477.4170324671;6484.837879053061;6487.513436492188;6519.902201467076;6407;6424.871502570016;6425.5502114851515;6430.453411460078;6438.67806609677;6541.967290163519;6546.149000629887;6546.934530654633;6548.377904099103;6552.934470655233;6247.875042499216;6379.936200637934;6384.489240860627;6391.93608063932;6393.328700486382 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: |5;yui.html;922.6171138977321;924.7179610218885;940.4686352211;944.6740874398334;945.9858102128474;13399.79900301495;13954.092983956036;14179.220142892163;14224;14238.430462781502;13916.860831391683;13941.860581394183;13965.371558279876;14030.649233769162;14044.087134336261;755.6221889055472;767.9731209407672;884;896.3098414221063;906.6237511432747;896.8116695493954;897.273208700951;904.5748498205833;904.9683261085863;905.483874191711;937.5780898595625;942.8868535775682;943.5423819447597;944.3153713557684;944.5324564340626;781.1134362498576;794.8489786940492;912.1699253679153;926.703454894434;929.7675581104724;690.7893092606753;690.7962151165368;691.0981169573704;693.2409012131708;696.0012382231514;13983.37074831635;14315.212663303515;14337.06809057408;14367.066140700925;14376.137431754129;12379.62861114168;12890.80663790044;13054.608361749162;13065.869341306561;13087.411066501934;10394.22043346752;10948.507317170746;11098;11110.944445277722;11723.765524689543;3890.7665540067687;3905.882823515299;3930.2728995135703;3961.841526338972;3972.245273398045;45312.546874531494;51467.227991580156;52152.21771673428;52189.21716174261;52388;10104;10183.490825458697;10550.314229575053;10668.413237271869;10924.726881827859;17888.731669024713;17895.642087158445;17901.28394864217;17909.28362865497;17965.281388744566;6421;6535.313792051861;6544.149260596092;6550.868982620416;6651.501137414713;4579.496255411902;4642.837500687528;4670.439547254351;4733.242681171065;4745.383100197021;3201.055688571877;3210.3258315753487;3225.419424503565;3232.111169428426;3239.481682930767;590.9911351329733;593.9287285525764;594.9791757288474;595.6991719181872;621.3227581935712;650.7559665125578;695.58265040975;695.9756408525677;723.4429489293215;736.9963150184215;8231.259186673227;8430.620622072021;8695.565221738887;9526.523673816282;9661.372010819274;528.9444608316071;588.2294194605081;708.2987842036347;716.0082539840307;747.2873469306383;4380.364847097153;4420.138073075719;4423.623991960655;4429.623482004065;4443.266860967969;55782.44217557772;55881.720591396785;56302.15546766802;56493.71753141208;56532.43467565354;51340.74329628328;51645.48354516482;52224.73887630613;52228.47771522236;52748.20877686838;46820;47363.76318118387;47621.28568071482;48078;48215.27677084847;8413.579321034047;8487;8592.570371481275;8833.29333653319;8834.911650883667;34292.65707342895;35336.82331588326;35895;36217.81891090528;36788.63211367959;44986.55013449954;45114.87212819706;45480;45583.77208113938;46783.53216467792;11560.364179970182;11826.231294965799;11883.881161188623;11892.940535297268;12152.57465988686;11683.299002059903;12032.318210068366;12074.577389791315;12239.449224785085;12399.814002789784;11750.118741094622;11852.76294474123;11872.347020913932;11894.167408281337;12032.699182520157;12074.094442916641;12084.154109212623;12095.092868034757;12197.268163910194;12347.38263086824;9272.692115088284;10044.899551004688;11596.652100437;12084.214526055779;12555.43500542496;10155.441450720282;10319.535620896928;10635.255532112678;10666.480271205533;10796.622118225825;10283.280170388001;10504.737381565523;10532.684019479428;10564.524596393334;10595.94702026485 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,944 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:02:36 INFO - 2016-02-25 11:02:36,866 DEBUG : BROWSER_OUTPUT: __startTimestamp1456426956858__endTimestamp 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5395.75 Median:5609.86 stddev:586.87 (10.5%) stddev-sans-first:562.33 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: Values: 3179.6 3311.0 3331.2 3343.8 3364.4 5361.1 5407.5 5409.5 5429.3 5439.1 5414.2 5419.1 5422.9 5453.8 5454.3 4820.0 4920.1 4940.5 4979.4 4998.0 4877.5 4932.2 4938.8 4941.8 4944.3 4896.7 4951.2 4962.8 4982.3 4999.6 4964.4 4973.5 5092.8 5097.2 5099.3 4982.4 4997.4 5004.9 5005.7 5030.3 5134.8 5166.3 5212.9 5254.2 5260.4 5815.6 5819.2 5836.9 5860.8 5876.2 5860.3 5865.3 5870.7 5874.4 5876.1 5236.1 5329.4 5389.7 5397.9 5509.1 5884.6 5912.4 5914.3 5922.6 5932.2 5720.5 5722.1 5722.4 5727.9 5728.0 5673.8 5688.3 5781.2 5781.5 5798.5 5707.7 5800.3 5806.9 5810.3 5813.1 5783.8 5798.9 5810.6 5828.2 5828.6 4408.9 4415.6 4445.6 4500.0 4506.7 3974.7 3976.8 3987.8 4006.4 4008.8 5263.3 5482.4 5484.0 5485.0 5494.5 5609.9 5696.2 5713.7 5724.9 5753.3 5458.6 5564.1 5568.4 5570.4 5571.7 4907.7 4994.8 5070.5 5088.6 5131.8 5879.2 5999.8 6005.6 6009.1 6037.2 5915.9 5934.7 5936.1 5944.6 5948.6 5838.3 5892.7 5939.0 6032.2 6049.9 5764.7 5778.6 5779.7 5796.0 5829.8 5777.2 5829.3 5832.4 5832.6 5838.7 5438.0 5579.7 5587.7 5636.2 5709.7 5558.1 5619.0 5619.6 5639.2 5649.5 5642.6 5663.2 5663.3 5672.1 5677.0 5400.1 5523.3 5656.7 5767.2 5780.2 5608.1 5617.7 5618.8 5625.9 5641.0 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,867 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45018.36 Median:32890.17 stddev:67874.22 (206.4%) stddev-sans-first:67982.68 11:02:36 INFO - 2016-02-25 11:02:36,868 DEBUG : BROWSER_OUTPUT: Values: 599.4 633.0 633.0 645.2 650.6 32405.8 41458.6 42048.0 42065.4 42071.2 45939.3 46730.5 46801.3 46820.3 46830.8 8040.3 8168.1 8173.6 9007.8 9195.0 10767.0 11004.7 11008.3 11011.1 11020.9 10671.7 10781.2 10784.2 10784.3 10787.6 10622.2 10622.9 10717.0 10720.7 10726.0 10280.7 10302.6 10357.8 10375.1 10391.7 42579.4 43054.0 43062.6 43063.1 43071.0 3696.1 3827.6 3935.0 4276.2 4334.7 32347.4 32554.5 32570.3 32684.0 32765.8 4331.3 4410.4 4440.9 4444.0 4499.8 294390.0 297020.0 298609.0 298628.0 301224.0 63380.7 63858.4 64776.7 64799.7 64970.4 63973.7 64124.7 64739.0 64781.7 64784.0 16828.4 17019.8 17047.1 17142.9 17148.8 12882.4 13096.1 13102.7 13199.2 13210.9 21149.5 21617.5 21624.7 21687.2 21709.6 7887.9 8137.6 8164.1 8212.0 8317.0 1069.1 1071.2 1087.3 1094.5 1167.9 29568.0 29757.7 30404.2 30489.0 30565.8 1126.2 1132.8 1150.3 1175.0 1200.7 13499.4 14073.4 14321.8 14952.3 16330.5 259799.0 263108.0 263858.0 264155.0 264177.0 53800.0 54579.5 54622.5 54703.7 54789.0 1474.8 1480.2 1493.6 1495.2 1499.6 24920.6 29490.8 30006.0 30387.8 30504.0 45610.5 46106.0 46108.0 46121.8 46125.8 214414.0 216585.0 216975.0 217165.0 217246.0 33071.3 33184.0 33570.2 33584.0 33584.8 44934.0 45289.0 45651.8 46189.1 46780.8 37954.8 38656.2 38965.6 38996.6 39233.2 37167.3 38028.6 38034.8 38621.8 38634.6 37424.3 37624.4 37858.8 37938.6 38039.4 33014.5 33817.0 33885.3 33920.8 34348.3 26019.5 26138.0 26210.2 26358.6 26687.0 11:02:36 INFO - 2016-02-25 11:02:36,868 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,868 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31506.61 Median:36213.23 stddev:102485.27 (283.0%) stddev-sans-first:102746.12 11:02:36 INFO - 2016-02-25 11:02:36,869 DEBUG : BROWSER_OUTPUT: Values: 378.1 381.9 383.3 383.3 392.5 15021.2 16436.2 17556.6 17632.2 17654.8 17408.6 17530.5 17536.1 18273.8 18391.4 5482.5 5629.2 5633.7 5636.0 5636.8 4253.0 4361.7 5657.4 6005.7 6184.8 6068.1 6176.1 6202.4 6232.3 6264.7 6142.5 6151.6 6155.3 6162.8 6166.4 5138.5 5470.2 5472.6 5476.2 5478.3 14113.4 14264.9 14307.8 18202.8 21514.8 2252.0 2273.7 2321.3 2324.7 2367.6 10135.8 10290.8 10392.0 10460.5 12201.0 1903.5 1924.2 1943.9 2013.3 2014.5 56933.0 58203.7 61566.4 64209.0 64867.0 10641.9 11000.3 11016.4 11136.2 11224.6 14454.5 14525.6 14527.5 14536.3 14544.9 7766.3 7808.4 7819.1 8116.3 8211.4 7269.5 7306.2 7520.5 7967.9 7993.1 4763.4 4803.8 4815.0 4821.6 4836.5 1718.8 1736.5 1807.7 1815.7 1816.6 452.8 463.8 468.5 480.7 963.2 9962.7 10525.8 10928.5 11115.6 11788.6 456.7 457.8 495.4 515.3 525.5 5453.9 6472.1 6589.8 6607.1 6728.2 616339.0 616622.0 630811.0 635422.0 635442.0 83656.0 84672.0 85926.6 88784.6 89346.0 532.0 541.7 542.0 542.3 542.5 10557.5 11188.8 11244.7 11306.8 11314.2 35708.6 36151.6 36274.8 36727.1 36794.6 50259.0 50662.0 52312.5 52753.2 54170.2 10245.3 10275.9 10439.5 10566.3 10566.8 17327.9 18101.6 18348.8 18650.3 18748.2 15119.1 15292.6 15325.4 15492.2 15651.6 11379.9 14805.9 14848.7 15495.8 15679.2 15142.6 15356.5 15372.8 15466.5 15583.8 10117.3 10499.5 10618.8 10619.1 10693.9 11256.5 14593.2 14853.6 14992.9 15140.0 11:02:36 INFO - 2016-02-25 11:02:36,870 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,870 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5509.23 Median:6592.74 stddev:2862.96 (43.4%) stddev-sans-first:2855.37 11:02:36 INFO - 2016-02-25 11:02:36,871 DEBUG : BROWSER_OUTPUT: Values: 1530.3 1537.9 1725.9 1790.3 1833.2 7662.2 7879.4 7881.6 7891.3 7892.6 7869.1 7929.1 7954.0 7961.8 7964.6 2313.0 2322.0 2343.4 2347.2 2350.5 2301.6 2330.5 2331.1 2332.9 2334.0 2001.6 2040.5 2277.6 2289.7 2338.1 2301.4 2323.7 2337.1 2340.3 2341.9 2280.0 2322.4 2328.9 2333.0 2334.6 6864.2 7053.6 7523.9 7691.3 7706.8 4755.7 4821.8 4838.3 4840.2 4842.7 3114.9 3127.7 3132.0 3164.7 3173.0 1016.2 1024.5 1036.4 1042.5 1055.7 10560.2 10604.3 10607.4 10623.1 10630.3 4184.9 4197.2 4201.9 4250.3 4279.3 9173.4 9177.5 9182.9 9185.0 9189.8 4651.6 4688.6 4690.0 4696.8 4697.2 4281.5 4286.6 4291.3 4295.9 4299.0 3579.7 3617.2 3641.8 3656.8 3661.7 1128.4 1130.6 1136.7 1141.6 1152.2 1061.8 1080.2 1082.7 1275.5 1406.0 7504.2 7582.7 7605.3 7645.5 7650.8 503.7 507.1 507.5 510.4 522.4 5725.2 6019.6 6072.5 6088.7 6096.2 8739.6 9408.2 9449.8 9452.7 9466.5 9065.4 9136.9 9278.8 9285.6 9507.2 7329.7 7338.4 7407.6 7410.2 7414.1 7443.1 7489.9 7529.0 7537.0 7559.6 8344.8 8466.3 8507.9 8508.1 8516.8 8382.9 8506.6 8657.7 8663.7 8741.6 7004.2 7008.0 7068.9 7070.9 7083.2 7520.7 7560.9 7609.4 7632.7 7660.3 7198.0 7240.6 7257.9 7321.3 7333.1 6943.7 6974.5 7038.7 7093.8 7137.2 7177.4 7180.9 7216.4 7232.2 7232.3 6573.8 6611.7 6633.3 6644.4 6645.5 6645.3 6670.3 6680.0 6683.0 6683.7 11:02:36 INFO - 2016-02-25 11:02:36,871 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,871 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5393.30 Median:6085.17 stddev:1582.07 (26.0%) stddev-sans-first:1540.97 11:02:36 INFO - 2016-02-25 11:02:36,871 DEBUG : BROWSER_OUTPUT: Values: 372.5 377.7 377.7 380.6 387.3 5872.8 5990.1 5995.6 6034.0 6054.3 5835.6 5980.5 5984.1 6006.0 6017.4 4721.8 4730.2 4731.6 4734.9 4736.0 4477.8 4563.5 4565.0 4693.1 4740.0 4641.7 4659.7 4667.5 4680.5 4704.2 4695.7 4711.8 4714.2 4715.0 4716.6 4184.6 4190.2 4192.3 4193.1 4199.4 5649.4 5742.1 5748.8 5754.7 5763.4 5483.9 5486.6 5487.6 5489.5 5495.1 6113.6 6363.1 6366.0 6369.9 6370.0 4488.4 4515.3 4641.4 4642.3 4645.4 6531.3 6581.8 6598.3 6602.8 6608.6 4750.9 4753.5 4756.5 4762.9 4770.6 4725.8 4778.3 4787.1 4794.2 4817.3 5398.1 5423.3 5432.0 5433.1 5436.2 6336.7 6369.2 6378.8 6383.2 6383.2 1696.5 1713.6 1714.1 1716.4 1717.5 1109.3 1115.2 1119.1 1121.3 1151.6 6203.4 6207.2 6210.9 6239.6 6246.6 6515.3 6555.5 6567.2 6567.4 6575.1 6056.7 6135.0 6135.0 6143.0 6218.7 3461.8 3552.1 3554.7 3562.7 3571.0 6701.1 6709.6 6714.9 6715.2 6720.7 6697.4 6704.2 6704.6 6706.8 6707.7 6559.0 6656.0 6661.3 6662.0 6702.5 6482.8 6525.6 6528.7 6571.7 6593.5 6528.8 6547.2 6558.9 6570.1 6571.9 6816.0 6833.0 6833.2 6837.5 6839.9 4584.9 4642.7 4643.7 4651.4 4656.7 6651.4 6662.3 6664.4 6672.1 6675.8 6490.3 6511.0 6511.3 6513.5 6516.5 6264.6 6477.4 6484.8 6487.5 6519.9 6407.0 6424.9 6425.6 6430.5 6438.7 6542.0 6546.1 6546.9 6548.4 6552.9 6247.9 6379.9 6384.5 6391.9 6393.3 11:02:36 INFO - 2016-02-25 11:02:36,872 DEBUG : BROWSER_OUTPUT: 11:02:36 INFO - 2016-02-25 11:02:36,872 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14167.74 Median:45213.71 stddev:16158.80 (35.7%) stddev-sans-first:16173.52 11:02:36 INFO - 2016-02-25 11:02:36,872 DEBUG : BROWSER_OUTPUT: Values: 922.6 924.7 940.5 944.7 946.0 13399.8 13954.1 14179.2 14224.0 14238.4 13916.9 13941.9 13965.4 14030.6 14044.1 755.6 768.0 884.0 896.3 906.6 896.8 897.3 904.6 905.0 905.5 937.6 942.9 943.5 944.3 944.5 781.1 794.8 912.2 926.7 929.8 690.8 690.8 691.1 693.2 696.0 13983.4 14315.2 14337.1 14367.1 14376.1 12379.6 12890.8 13054.6 13065.9 13087.4 10394.2 10948.5 11098.0 11110.9 11723.8 3890.8 3905.9 3930.3 3961.8 3972.2 45312.5 51467.2 52152.2 52189.2 52388.0 10104.0 10183.5 10550.3 10668.4 10924.7 17888.7 17895.6 17901.3 17909.3 17965.3 6421.0 6535.3 6544.1 6550.9 6651.5 4579.5 4642.8 4670.4 4733.2 4745.4 3201.1 3210.3 3225.4 3232.1 3239.5 591.0 593.9 595.0 595.7 621.3 650.8 695.6 696.0 723.4 737.0 8231.3 8430.6 8695.6 9526.5 9661.4 528.9 588.2 708.3 716.0 747.3 4380.4 4420.1 4423.6 4429.6 4443.3 55782.4 55881.7 56302.2 56493.7 56532.4 51340.7 51645.5 52224.7 52228.5 52748.2 46820.0 47363.8 47621.3 48078.0 48215.3 8413.6 8487.0 8592.6 8833.3 8834.9 34292.7 35336.8 35895.0 36217.8 36788.6 44986.6 45114.9 45480.0 45583.8 46783.5 11560.4 11826.2 11883.9 11892.9 12152.6 11683.3 12032.3 12074.6 12239.4 12399.8 11750.1 11852.8 11872.3 11894.2 12032.7 12074.1 12084.2 12095.1 12197.3 12347.4 9272.7 10044.9 11596.7 12084.2 12555.4 10155.4 10319.5 10635.3 10666.5 10796.6 10283.3 10504.7 10532.7 10564.5 10595.9 11:02:36 INFO - 2016-02-25 11:02:36,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:02:36 INFO - 2016-02-25 11:02:36,873 DEBUG : BROWSER_OUTPUT: 11:02:37 INFO - 2016-02-25 11:02:37,469 INFO : Browser exited with error code: 0 11:02:37 INFO - 2016-02-25 11:02:37,490 INFO : Completed test dromaeo_css (00:18:30) 11:02:37 INFO - 2016-02-25 11:02:37,491 INFO : Starting test kraken 11:02:37 INFO - 2016-02-25 11:02:37,491 DEBUG : operating with platform_type : linux_ 11:02:37 INFO - 2016-02-25 11:02:37,491 INFO : Initialising browser for kraken test... 11:02:37 INFO - 2016-02-25 11:02:37,497 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphE7ocW/profile http://localhost:46293/getInfo.html 11:02:41 INFO - 2016-02-25 11:02:41,353 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:02:41 INFO - 2016-02-25 11:02:41,353 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:02:41 INFO - 2016-02-25 11:02:41,354 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:02:41 INFO - 2016-02-25 11:02:41,354 DEBUG : BROWSER_OUTPUT: __metrics 11:02:41 INFO - 2016-02-25 11:02:41,496 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] 11:02:42 INFO - 2016-02-25 11:02:42,577 INFO : Browser initialized. 11:02:42 INFO - 2016-02-25 11:02:42,578 INFO : Running cycle 1/1 for kraken test... 11:02:42 INFO - 2016-02-25 11:02:42,578 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphE7ocW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:02:54 INFO - 2016-02-25 11:02:54,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 134541312 11:02:54 INFO - 2016-02-25 11:02:54,276 DEBUG : BROWSER_OUTPUT: 11:02:56 INFO - 2016-02-25 11:02:56,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46293/tests/kraken/driver.html?testName=audio-beat-detection) 11:02:57 INFO - 2016-02-25 11:02:57,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 164425728 11:02:57 INFO - 2016-02-25 11:02:57,298 DEBUG : BROWSER_OUTPUT: 11:02:59 INFO - 2016-02-25 11:02:59,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46293/tests/kraken/driver.html?testName=audio-dft) 11:03:00 INFO - 2016-02-25 11:03:00,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 162275328 11:03:00 INFO - 2016-02-25 11:03:00,445 DEBUG : BROWSER_OUTPUT: 11:03:03 INFO - 2016-02-25 11:03:03,245 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46293/tests/kraken/driver.html?testName=audio-fft) 11:03:03 INFO - 2016-02-25 11:03:03,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 159096832 11:03:03 INFO - 2016-02-25 11:03:03,818 DEBUG : BROWSER_OUTPUT: 11:03:05 INFO - 2016-02-25 11:03:05,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46293/tests/kraken/driver.html?testName=audio-oscillator) 11:03:06 INFO - 2016-02-25 11:03:06,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 158445568 11:03:06 INFO - 2016-02-25 11:03:06,339 DEBUG : BROWSER_OUTPUT: 11:03:08 INFO - 2016-02-25 11:03:08,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:03:09 INFO - 2016-02-25 11:03:09,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 159035392 11:03:09 INFO - 2016-02-25 11:03:09,069 DEBUG : BROWSER_OUTPUT: 11:03:11 INFO - 2016-02-25 11:03:11,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46293/tests/kraken/driver.html?testName=imaging-darkroom) 11:03:12 INFO - 2016-02-25 11:03:12,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 157806592 11:03:12 INFO - 2016-02-25 11:03:12,510 DEBUG : BROWSER_OUTPUT: 11:03:15 INFO - 2016-02-25 11:03:15,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46293/tests/kraken/driver.html?testName=imaging-desaturate) 11:03:16 INFO - 2016-02-25 11:03:16,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 159444992 11:03:16 INFO - 2016-02-25 11:03:16,442 DEBUG : BROWSER_OUTPUT: 11:03:19 INFO - 2016-02-25 11:03:19,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46293/tests/kraken/driver.html?testName=json-parse-financial) 11:03:19 INFO - 2016-02-25 11:03:19,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 158449664 11:03:19 INFO - 2016-02-25 11:03:19,712 DEBUG : BROWSER_OUTPUT: 11:03:21 INFO - 2016-02-25 11:03:21,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:03:21 INFO - 2016-02-25 11:03:21,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 165208064 11:03:21 INFO - 2016-02-25 11:03:21,842 DEBUG : BROWSER_OUTPUT: 11:03:23 INFO - 2016-02-25 11:03:23,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:03:24 INFO - 2016-02-25 11:03:24,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 163598336 11:03:24 INFO - 2016-02-25 11:03:24,199 DEBUG : BROWSER_OUTPUT: 11:03:26 INFO - 2016-02-25 11:03:26,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:03:26 INFO - 2016-02-25 11:03:26,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 170049536 11:03:26 INFO - 2016-02-25 11:03:26,732 DEBUG : BROWSER_OUTPUT: 11:03:29 INFO - 2016-02-25 11:03:29,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:03:29 INFO - 2016-02-25 11:03:29,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 175230976 11:03:29 INFO - 2016-02-25 11:03:29,741 DEBUG : BROWSER_OUTPUT: 11:03:32 INFO - 2016-02-25 11:03:32,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:03:32 INFO - 2016-02-25 11:03:32,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 173506560 11:03:32 INFO - 2016-02-25 11:03:32,862 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,497 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46293/tests/kraken/driver.html?testName=ai-astar) 11:03:34 INFO - 2016-02-25 11:03:34,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 232763392 11:03:34 INFO - 2016-02-25 11:03:34,755 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,755 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:03:34 INFO - 2016-02-25 11:03:34,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;105;112;110;110;100;109;110;109 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;150;160;127;150;152;132;161;124 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;159;159;159;163;161;160 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;152;72;72;72;73;147;73 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;136;92;93;93;144;92;93;130 11:03:34 INFO - 2016-02-25 11:03:34,756 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;109;109;109;109;110 11:03:34 INFO - 2016-02-25 11:03:34,757 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;145;145;146;145;146 11:03:34 INFO - 2016-02-25 11:03:34,757 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;97 11:03:34 INFO - 2016-02-25 11:03:34,757 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;59;57;57;58;59;58;56;58 11:03:34 INFO - 2016-02-25 11:03:34,757 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;63;64;64;64;64;65;70;64 11:03:34 INFO - 2016-02-25 11:03:34,757 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;75;77;78;79;79;78;79;77;77 11:03:34 INFO - 2016-02-25 11:03:34,758 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;118;110;116;121;112;121;118;111;115 11:03:34 INFO - 2016-02-25 11:03:34,758 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;147;152;144;146;140;148;146;159;134 11:03:34 INFO - 2016-02-25 11:03:34,758 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;65;64;65;64;65;64;67;64;67 11:03:34 INFO - 2016-02-25 11:03:34,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:03:34 INFO - 2016-02-25 11:03:34,758 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,885 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: __startTimestamp1456427014750__endTimestamp 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:03:34 INFO - 2016-02-25 11:03:34,759 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.60 (3.3%) stddev-sans-first:3.81 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 105.0 112.0 110.0 110.0 100.0 109.0 110.0 109.0 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.00 Median:150.50 stddev:14.88 (9.9%) stddev-sans-first:15.50 11:03:34 INFO - 2016-02-25 11:03:34,760 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 150.0 160.0 127.0 150.0 152.0 132.0 161.0 124.0 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 159.0 159.0 159.0 163.0 161.0 160.0 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:72.00 stddev:32.70 (45.4%) stddev-sans-first:34.20 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 152.0 72.0 72.0 72.0 73.0 147.0 73.0 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,761 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:21.43 (23.0%) stddev-sans-first:22.20 11:03:34 INFO - 2016-02-25 11:03:34,762 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 136.0 92.0 93.0 93.0 144.0 92.0 93.0 130.0 11:03:34 INFO - 2016-02-25 11:03:34,762 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,762 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:03:34 INFO - 2016-02-25 11:03:34,762 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.15 (2.0%) stddev-sans-first:0.97 11:03:34 INFO - 2016-02-25 11:03:34,763 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 59.0 57.0 57.0 58.0 59.0 58.0 56.0 58.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 64.0 64.0 64.0 64.0 65.0 70.0 64.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:2.36 (3.0%) stddev-sans-first:1.32 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: Values: 84.0 75.0 77.0 78.0 79.0 79.0 78.0 79.0 77.0 77.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:3.88 (3.3%) stddev-sans-first:4.12 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: Values: 116.0 118.0 110.0 116.0 121.0 112.0 121.0 118.0 111.0 115.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:146.50 stddev:7.36 (5.0%) stddev-sans-first:7.01 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: Values: 136.0 147.0 152.0 144.0 146.0 140.0 148.0 146.0 159.0 134.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.32 (2.0%) stddev-sans-first:1.22 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 64.0 65.0 64.0 65.0 64.0 67.0 64.0 67.0 11:03:34 INFO - 2016-02-25 11:03:34,764 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:03:34 INFO - 2016-02-25 11:03:34,765 DEBUG : BROWSER_OUTPUT: 11:03:35 INFO - 2016-02-25 11:03:35,433 INFO : Browser exited with error code: 0 11:03:35 INFO - 2016-02-25 11:03:35,487 INFO : Completed test kraken (00:00:57) 11:03:35 INFO - 2016-02-25 11:03:35,487 INFO : Starting test v8_7 11:03:35 INFO - 2016-02-25 11:03:35,487 DEBUG : operating with platform_type : linux_ 11:03:35 INFO - 2016-02-25 11:03:35,487 INFO : Initialising browser for v8_7 test... 11:03:35 INFO - 2016-02-25 11:03:35,494 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFIH3XE/profile http://localhost:46293/getInfo.html 11:03:39 INFO - 2016-02-25 11:03:39,279 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:03:39 INFO - 2016-02-25 11:03:39,280 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:03:39 INFO - 2016-02-25 11:03:39,281 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:03:39 INFO - 2016-02-25 11:03:39,281 DEBUG : BROWSER_OUTPUT: __metrics 11:03:39 INFO - 2016-02-25 11:03:39,619 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] 11:03:40 INFO - 2016-02-25 11:03:40,537 INFO : Browser initialized. 11:03:40 INFO - 2016-02-25 11:03:40,538 INFO : Running cycle 1/1 for v8_7 test... 11:03:40 INFO - 2016-02-25 11:03:40,538 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFIH3XE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:03:52 INFO - 2016-02-25 11:03:52,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 134324224 11:03:52 INFO - 2016-02-25 11:03:52,238 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46293/tests/v8_7/run.html (next: http://localhost:46293/tests/v8_7/run.html) 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 424849408 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:04:13 INFO - 2016-02-25 11:04:13,833 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |0;Richards;172.8608470181504 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.53550736633008 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.3476310625175 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |5;Earley;574.7126436781609 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;10589.473684210527 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |7;RegExp;24390.243902439026 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |8;Splay;524.3838489774515 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1456427053830__endTimestamp 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:04:13 INFO - 2016-02-25 11:04:13,834 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.86 Median:172.86 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: Values: 172.9 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: Values: 165.5 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: Values: 280.3 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,835 DEBUG : BROWSER_OUTPUT: Values: 5148.7 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: Values: 941.6 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:574.71 Median:574.71 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: Values: 574.7 11:04:13 INFO - 2016-02-25 11:04:13,836 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10589.47 Median:10589.47 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: Values: 10589.5 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24390.24 Median:24390.24 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: Values: 24390.2 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.38 Median:524.38 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,837 DEBUG : BROWSER_OUTPUT: Values: 524.4 11:04:13 INFO - 2016-02-25 11:04:13,838 DEBUG : BROWSER_OUTPUT: 11:04:13 INFO - 2016-02-25 11:04:13,838 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:04:13 INFO - 2016-02-25 11:04:13,838 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:04:13 INFO - 2016-02-25 11:04:13,838 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:04:13 INFO - 2016-02-25 11:04:13,838 DEBUG : BROWSER_OUTPUT: 11:04:14 INFO - 2016-02-25 11:04:14,561 INFO : Browser exited with error code: 0 11:04:14 INFO - 2016-02-25 11:04:14,578 INFO : Completed test v8_7 (00:00:39) 11:04:14 INFO - 2016-02-25 11:04:14,870 INFO : Completed test suite (00:20:07) 11:04:14 INFO - 2016-02-25 11:04:14,870 DEBUG : Working with test: dromaeo_css 11:04:14 INFO - 2016-02-25 11:04:14,870 DEBUG : Generating results file: dromaeo_css 11:04:14 INFO - 2016-02-25 11:04:14,871 DEBUG : Working with test: kraken 11:04:14 INFO - 2016-02-25 11:04:14,871 DEBUG : Generating results file: kraken 11:04:14 INFO - 2016-02-25 11:04:14,872 INFO : javascript benchmark 11:04:14 INFO - 2016-02-25 11:04:14,872 DEBUG : Working with test: v8_7 11:04:14 INFO - 2016-02-25 11:04:14,872 DEBUG : Generating results file: v8_7 11:04:14 INFO - 2016-02-25 11:04:14,872 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:14 INFO - 2016-02-25 11:04:14,931 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 11:04:14 INFO - 2016-02-25 11:04:14,931 DEBUG : process_Request line: dromaeo_css 7114.22 graph.html#tests=[[72,53,35]] 11:04:14 INFO - 2016-02-25 11:04:14,931 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:14 INFO - 2016-02-25 11:04:14,973 DEBUG : process_Request line: kraken 1483.10 graph.html#tests=[[232,53,35]] 11:04:14 INFO - 2016-02-25 11:04:14,973 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:15 INFO - 2016-02-25 11:04:15,003 DEBUG : process_Request line: v8_7 23063.35 graph.html#tests=[[230,53,35]] 11:04:15 INFO - 2016-02-25 11:04:15,004 INFO : javascript benchmark 11:04:15 INFO - 2016-02-25 11:04:15,008 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3179.60254968129, 3310.9834450827743, 3331.2005118771503, 3343.8160901150427, 3364.394409006378, 5361.061814182517, 5407.5133238008575, 5409.459054094588, 5429.294191755072, 5439.129739241722, 5414.160805075219, 5419.051665958461, 5422.864428389292, 5453.809116680917, 5454.318210223722, 4819.975900120495, 4920.065187614359, 4940.5059494050665, 4979.352684151056, 4998.025385049917, 4877.53663401978, 4932.235503496946, 4938.7530623468865, 4941.827036053739, 4944.307796908436, 4896.706197628136, 4951.207806750921, 4962.751862406883, 4982.252662100677, 4999.60003199745, 4964.429090654585, 4973.477784832577, 5092.79628814847, 5097.184450487941, 5099.3370861787735, 4982.377202849644, 4997.375328083989, 5004.949950500485, 5005.6996580205305, 5030.2957585938, 5134.794608215667, 5166.302549155891, 5212.8957420851375, 5254.238135470336, 5260.395054568736, 5815.592908496407, 5819.156222347736, 5836.854078648025, 5860.765569377262, 5876.177335173079, 5860.326062502824, 5865.296164460292, 5870.677112758796, 5874.353821079678, 5876.1479585459865, 5236.083685355047, 5329.440408757064, 5389.676619402849, 5397.865053373658, 5509.146082357241, 5884.646921184657, 5912.438318359749, 5914.319853216849, 5922.555808314393, 5932.169496270526, 5720.485156335866, 5722.141678748221, 5722.4277572242445, 5727.8854422912145, 5727.971360143172, 5673.801416950387, 5688.345840228344, 5781.19063331134, 5781.508571771446, 5798.5071268941765, 5707.71461426927, 5800.332961709373, 5806.854828629318, 5810.331811841608, 5813.128030795415, 5783.768649253982, 5798.8550286242335, 5810.564207684356, 5828.242328497268, 5828.562857785683, 4408.933865992013, 4415.62467190286, 4445.5776701213335, 4499.955000449953, 4506.684532082722, 3974.6621537169085, 3976.7812770297332, 3987.8205480753436, 4006.3990401439432, 4008.7995600219874, 5263.26314315996, 5482.369527504388, 5483.972580137074, 5484.957858006966, 5494.532964697965, 5609.8597535061135, 5696.174054762037, 5713.714314284269, 5724.914126288109, 5753.252077229933, 5458.563314934796, 5564.109742441271, 5568.415316391802, 5570.359408668055, 5571.721413929287, 4907.68100073494, 4994.80020799164, 5070.518300761421, 5088.592912566985, 5131.79472821083, 5879.20630714848, 5999.790007349722, 6005.579609427386, 6009.098635204667, 6037.215162028908, 5915.940840591625, 5934.703264836828, 5936.050231962865, 5944.613600115978, 5948.5538584605465, 5838.299404071538, 5892.734826932712, 5939.049752039653, 6032.215811944419, 6049.909251361145, 5764.6829424380385, 5778.595498315246, 5779.739911703899, 5796.04365279741, 5829.795957141479, 5777.24895763548, 5829.329627092939, 5832.387599302182, 5832.62087964281, 5838.708064596668, 5437.972810136082, 5579.693116878449, 5587.69267690281, 5636.239107720569, 5709.7430615623225, 5558.138488534284, 5619.0, 5619.578531610064, 5639.154126881001, 5649.4633009864, 5642.633228840113, 5663.150527420919, 5663.348714897839, 5672.064109421899, 5677.0, 5400.081986062457, 5523.337199536081, 5656.745446455002, 5767.163761254678, 5780.21967034445, 5608.130739735348, 5617.691026993554, 5618.831435056954, 5625.8593535161945, 5640.971795140998], "unit": "ms", "name": "dojo.html", "value": 5358.650623624634}, {"lowerIsBetter": false, "replicates": [599.4095815621612, 632.9746810127592, 632.9873402531947, 645.2418408370164, 650.6226388694556, 32405.837970810142, 41458.585414145884, 42048.0, 42065.369019464735, 42071.158576828486, 45939.310910336375, 46730.53269467304, 46801.29798053023, 46820.29769553451, 46830.765846170805, 8040.316573091265, 8168.142345053773, 8173.632186551619, 9007.819843603123, 9195.0, 10767.0, 11004.724881877977, 11008.339499630009, 11011.119110471183, 11020.944895275512, 10671.733206669856, 10781.191410644233, 10784.191185661068, 10784.299020563678, 10787.5684972601, 10622.203334749925, 10622.893771062269, 10717.035466808025, 10720.731981700443, 10726.034656880918, 10280.74298142545, 10302.587896484132, 10357.844632330522, 10375.118114960238, 10391.740206494822, 42579.36130958038, 43054.0, 43062.56937430617, 43063.13873722508, 43071.0, 3696.075981004749, 3827.61723827615, 3935.0162459385156, 4276.23027854986, 4334.718243314206, 32347.353052939045, 32554.511682324784, 32570.348593028244, 32684.019479415656, 32765.83617081923, 4331.328644060176, 4410.448693913261, 4440.866773996785, 4443.977780111111, 4499.820007199708, 294390.0, 297020.0, 298609.0, 298628.0, 301224.0, 63380.683096584224, 63858.36141638617, 64776.67611661911, 64799.67600161969, 64970.350296497374, 63973.680131599045, 64124.67937660282, 64739.0, 64781.67609161924, 64784.0, 16828.411005614744, 17019.82980170207, 17047.062411567236, 17142.914285428742, 17148.828511714724, 12882.355882205853, 13096.148750331198, 13102.672433189247, 13199.20804751718, 13210.933945330213, 21149.471263218235, 21617.459563511038, 21624.675629865564, 21687.240946566795, 21709.56580868374, 7887.912296568796, 8137.5931203439595, 8164.142765009708, 8212.0, 8316.958415207886, 1069.1072954083272, 1071.223363061774, 1087.260662749338, 1094.4965315954591, 1167.8598568171874, 29568.0, 29757.702422975926, 30404.239894002825, 30489.0, 30565.847170764006, 1126.189143816451, 1132.841402203692, 1150.3443037468562, 1174.9647510574696, 1200.6578125234266, 13499.392527336293, 14073.366698498592, 14321.78517322241, 14952.327145278488, 16330.51008469724, 259799.0, 263108.0, 263858.0, 264155.0, 264177.0, 53800.0, 54579.454205457434, 54622.453775462534, 54703.72648136813, 54789.0, 1474.7787831825312, 1480.178500931993, 1493.6415260337442, 1495.2000679636342, 1499.6475828180369, 24920.626190606792, 29490.82811579462, 30006.0, 30387.84806076044, 30504.0, 45610.54389456063, 46106.0, 46108.0, 46121.76939115417, 46125.76937115293, 214414.0, 216585.0, 216975.0, 217165.0, 217246.0, 33071.33857322888, 33184.0, 33570.16074598057, 33584.0, 33584.83207583946, 44934.0, 45289.0, 45651.771741141085, 46189.07621847611, 46780.766096170664, 37954.81022594869, 38656.2268754629, 38965.61034389733, 38996.6100338993, 39233.2153356937, 37167.25665486621, 38028.619713803615, 38034.809825950695, 38621.80689096537, 38634.6136538631, 37424.25151497009, 37624.43563346607, 37858.8107059474, 37938.62061379351, 38039.42940855834, 33014.50478242876, 33817.0, 33885.32229355448, 33920.805449093, 34348.31303373868, 26019.479610408063, 26138.0, 26210.213693589223, 26358.604620931084, 26687.0], "unit": "ms", "name": "ext.html", "value": 19722.349005623255}, {"lowerIsBetter": false, "replicates": [378.0737193875007, 381.88108841095595, 383.2909118131457, 383.34830787660985, 392.47408472646646, 15021.248937553133, 16436.178191090443, 17556.56108597286, 17632.206550705218, 17654.823451765493, 17408.56478588036, 17530.474085777416, 17536.12319384029, 18273.81726182738, 18391.448256552325, 5482.451754824526, 5629.155626656014, 5633.7183140843, 5635.971820140914, 5636.830895073133, 4252.9787351063205, 4361.672874534423, 5657.405972372882, 6005.699715014253, 6184.81445556634, 6068.059450785136, 6176.073588961669, 6202.379762023784, 6232.252129744437, 6264.686765661721, 6142.539309551801, 6151.630902145863, 6155.322914479404, 6162.7534898604, 6166.445019948182, 5138.460461651547, 5470.234167216593, 5472.644278121909, 5476.2333273341765, 5478.260434841325, 14113.364898579588, 14264.857351426457, 14307.785383219156, 18202.817971820376, 21514.78485215159, 2251.9774802252095, 2273.6816845641624, 2321.3152120124437, 2324.697789287382, 2367.6093444581625, 10135.797284054352, 10290.845637315446, 10392.0, 10460.476976151162, 12201.0, 1903.4860587641397, 1924.2110734598748, 1943.8833669979847, 2013.345662659627, 2014.5064459207588, 56933.0, 58203.708981455246, 61566.384336156516, 64209.0, 64867.0, 10641.946790266, 11000.284981476178, 11016.394098324668, 11136.164787640959, 11224.607138750105, 14454.494092706705, 14525.636859078397, 14527.491537796337, 14536.27318634064, 14544.85455145435, 7766.262205090507, 7808.375329973588, 7819.139894611588, 8116.269535741693, 8211.384146189059, 7269.491135620561, 7306.159791623925, 7520.511166774142, 7967.880481792662, 7993.080795708568, 4763.404574428197, 4803.78382972767, 4814.9518504815205, 4821.566059054632, 4836.46798852126, 1718.7937447506379, 1736.4773240922132, 1807.7198034304704, 1815.7185636226407, 1816.554944038719, 452.77587594140454, 463.75884540039664, 468.54082998661505, 480.70917095157625, 963.2390411574777, 9962.701118966443, 10525.789484210427, 10928.508217130247, 11115.55537778496, 11788.646340609796, 456.6597884576012, 457.7711144427786, 495.38819557846034, 515.2966201135423, 525.4823998361611, 5453.945460545423, 6472.093906853044, 6589.80230593083, 6607.14107166075, 6728.226253980757, 616339.0, 616622.0, 630811.0, 635422.0, 635442.0, 83656.0, 84672.0, 85926.57036714777, 88784.5560772192, 89346.0, 532.0, 541.73996481689, 541.9783208671688, 542.3275138827825, 542.533421257718, 10557.472126393803, 11188.776224475629, 11244.718882028015, 11306.773864522498, 11314.15143864197, 35708.64291357157, 36151.63848361483, 36274.8186259067, 36727.08182295464, 36794.632053680194, 50259.0, 50662.0, 52312.47687523076, 52753.153639622426, 54170.18744718911, 10245.282830201815, 10275.897241027495, 10439.530221139916, 10566.313189642957, 10566.788664226518, 17327.91336043312, 18101.637967240844, 18348.81651183471, 18650.253989840254, 18748.15633296532, 15119.092854428329, 15292.617684557976, 15325.386984520494, 15492.225388730292, 15651.608709782347, 11379.886201138213, 14805.925970370079, 14848.703025939205, 15495.767563486332, 15679.216039198223, 15142.621434464227, 15356.46252381206, 15372.846271537588, 15466.5360039199, 15583.76624350613, 10117.342372745748, 10499.475026248505, 10618.8407173894, 10619.097376723064, 10693.9465302673, 11256.493457794582, 14593.197374144524, 14853.554393368217, 14992.925035374754, 15140.0], "unit": "ms", "name": "jquery.html", "value": 8530.172679617142}, {"lowerIsBetter": false, "replicates": [1530.3419529602268, 1537.8692811111061, 1725.8705597080223, 1790.2659909437132, 1833.211718960847, 7662.195469475709, 7879.40904432167, 7881.605919704013, 7891.250331218539, 7892.6448309826055, 7869.055713314396, 7929.088154862193, 7954.045514538249, 7961.76114716558, 7964.641591128398, 2313.0, 2321.965170522435, 2343.4024323797494, 2347.248880358286, 2350.482893763378, 2301.5972204864165, 2330.5222429402015, 2331.1491305673394, 2332.941676458085, 2333.9533209335805, 2001.5596568754922, 2040.5102775333887, 2277.635578307471, 2289.748127705951, 2338.0530884991604, 2301.436148143707, 2323.6979192705007, 2337.1002164166835, 2340.3330050935488, 2341.8594884306995, 2280.0, 2322.396176993977, 2328.918487852934, 2333.0, 2334.6381310896836, 6864.176298844171, 7053.612051337174, 7523.924760752432, 7691.346235569983, 7706.768796936045, 4755.738434386108, 4821.7589120543835, 4838.298446725205, 4840.177169881129, 4842.66101372904, 3114.859831307597, 3127.687231276877, 3132.0447263584597, 3164.746820254374, 3172.952405713893, 1016.16166662503, 1024.5440778853413, 1036.4299635200684, 1042.5152304178594, 1055.6569115037644, 10560.155187584975, 10604.310719803188, 10607.363558186456, 10623.097036751808, 10630.309029913109, 4184.895377615584, 4197.24449599069, 4201.852935147255, 4250.3199488081755, 4279.33670281107, 9173.44959302444, 9177.541122943827, 9182.90817091834, 9184.954075229714, 9189.81620367589, 4651.62786977041, 4688.5545873142, 4690.0, 4696.835610753607, 4697.224957881979, 4281.529031806499, 4286.571342865688, 4291.291936830388, 4295.892602684896, 4298.978505107454, 3579.713622910161, 3617.1680513482047, 3641.7632853864416, 3656.835442405098, 3661.7436779425184, 1128.368113856243, 1130.5873356224918, 1136.687126369045, 1141.5890279499374, 1152.1704372851534, 1061.803566340214, 1080.195254535376, 1082.6697857153486, 1275.5408053100875, 1406.0157889477407, 7504.212057733968, 7582.734604288823, 7605.277498637621, 7645.503042302233, 7650.8087297818, 503.7380562107683, 507.092304774457, 507.53814029233223, 510.4461659099844, 522.3992408729991, 5725.1698503716725, 6019.638821670714, 6072.453479186895, 6088.726007329681, 6096.207493025879, 8739.606717697592, 9408.247340212767, 9449.811003779885, 9452.669156579486, 9466.526673666427, 9065.41074830134, 9136.908630913738, 9278.768030799283, 9285.628574857064, 9507.239420846316, 7329.74345897891, 7338.4496162788, 7407.592582407911, 7410.221926697727, 7414.110306763115, 7443.144038435649, 7489.8876516851205, 7528.962355188189, 7536.962315188389, 7559.622018899143, 8344.791380215544, 8466.280366168945, 8507.914920850711, 8508.064112947446, 8516.829663406574, 8382.874256886029, 8506.617202226038, 8657.653693852175, 8663.696770613251, 8741.606627701896, 7004.229534751275, 7008.0, 7068.858622827617, 7070.893936590853, 7083.1854336749875, 7520.736774212876, 7560.924390756242, 7609.429292802951, 7632.69469221225, 7660.310572048543, 7198.0, 7240.637968101469, 7257.891131633135, 7321.341079302888, 7333.1200255969625, 6943.652817359213, 6974.476914231352, 7038.683259253448, 7093.82265443368, 7137.179224389054, 7177.425805935617, 7180.856382872209, 7216.422686185198, 7232.168300645493, 7232.276772322725, 6573.80278591643, 6611.669416529058, 6633.270340262471, 6644.4020038196795, 6645.501587380869, 6645.335466453316, 6670.299618540177, 6679.966600166968, 6683.0, 6683.732650693918], "unit": "ms", "name": "mootools.html", "value": 4451.409660532546}, {"lowerIsBetter": false, "replicates": [372.4896891258975, 377.6619925166976, 377.69218087258884, 380.6345907928389, 387.2815926456423, 5872.7944521941745, 5990.10148477728, 5995.550333724967, 6034.0, 6054.273487181539, 5835.649861008332, 5980.521558275327, 5984.132300816379, 6005.969970150154, 6017.368176341487, 4721.787519561611, 4730.172219861528, 4731.597814185799, 4734.857954261361, 4735.976320118394, 4477.843275485358, 4563.452385713703, 4565.041341318327, 4693.108309421199, 4740.028294199681, 4641.651876109288, 4659.697119687226, 4667.4632417272105, 4680.5085466026085, 4704.223803072506, 4695.71825690458, 4711.835085772016, 4714.245720684708, 4715.033418149288, 4716.599089077433, 4184.602462766033, 4190.20386126635, 4192.308269135589, 4193.056562273495, 4199.4120823084795, 5649.350324712669, 5742.08126699726, 5748.798792042258, 5754.712264386806, 5763.366029736768, 5483.862903427406, 5486.61593688442, 5487.64330318528, 5489.451054894518, 5495.065838807413, 6113.633182009094, 6363.109164716943, 6366.045093236005, 6369.904451433232, 6369.9681501592195, 4488.41650585425, 4515.300128480091, 4641.396618439581, 4642.303654451825, 4645.396098507173, 6531.346865313478, 6581.802545923582, 6598.340165983412, 6602.8349291268105, 6608.570442921195, 4750.857474275777, 4753.5008824072975, 4756.453007904066, 4762.928556071662, 4770.594499467584, 4725.787339569728, 4778.331033655291, 4787.138315103245, 4794.232922732346, 4817.349657796152, 5398.055340315429, 5423.294971653739, 5432.02223599748, 5433.0763770159165, 5436.157395603688, 6336.651484168323, 6369.235691717024, 6378.808635740936, 6383.202099737533, 6383.202099737533, 1696.5334533003277, 1713.6487020160837, 1714.0829656133908, 1716.4421562992077, 1717.4504158669106, 1109.2955972957068, 1115.1914861725347, 1119.082352470966, 1121.2991880074953, 1151.573917650458, 6203.410675985774, 6207.224096987877, 6210.875782484325, 6239.625622462576, 6246.562740608114, 6515.283318834924, 6555.508336874754, 6567.244766851778, 6567.408933196035, 6575.112359831362, 6056.697165141725, 6134.957057300269, 6135.0, 6143.017117261216, 6218.689065546704, 3461.8442170102408, 3552.1297282166033, 3554.7156227501737, 3562.7327950403824, 3571.035820328497, 6701.061851340816, 6709.630970296681, 6714.899276510856, 6715.1941766988275, 6720.731170753213, 6697.397234248843, 6704.161979752531, 6704.59772413647, 6706.765263215764, 6707.664616769142, 6558.967205163944, 6656.0348749430095, 6661.300563440769, 6662.034005069335, 6702.463802895757, 6482.773102941374, 6525.608463492205, 6528.67356632176, 6571.671416429255, 6593.505487088583, 6528.836779080561, 6547.214334279917, 6558.868822623616, 6570.080188773671, 6571.934280657132, 6815.965920170367, 6833.043373927555, 6833.214180369321, 6837.453003759588, 6839.871421215444, 4584.862454126382, 4642.698224615389, 4643.721376717408, 4651.395318608559, 4656.743879086547, 6651.368120028589, 6662.267150613526, 6664.366885145903, 6672.065910772592, 6675.766348177791, 6490.253620833476, 6510.990796426561, 6511.251206111168, 6513.54405191632, 6516.5112616553, 6264.5614806964895, 6477.4170324671, 6484.837879053061, 6487.513436492188, 6519.902201467076, 6407.0, 6424.871502570016, 6425.5502114851515, 6430.453411460078, 6438.67806609677, 6541.967290163519, 6546.149000629887, 6546.934530654633, 6548.377904099103, 6552.934470655233, 6247.875042499216, 6379.936200637934, 6384.489240860627, 6391.93608063932, 6393.328700486382], "unit": "ms", "name": "prototype.html", "value": 4892.873100877871}, {"lowerIsBetter": false, "replicates": [922.6171138977321, 924.7179610218885, 940.4686352211, 944.6740874398334, 945.9858102128474, 13399.79900301495, 13954.092983956036, 14179.220142892163, 14224.0, 14238.430462781502, 13916.860831391683, 13941.860581394183, 13965.371558279876, 14030.649233769162, 14044.087134336261, 755.6221889055472, 767.9731209407672, 884.0, 896.3098414221063, 906.6237511432747, 896.8116695493954, 897.273208700951, 904.5748498205833, 904.9683261085863, 905.483874191711, 937.5780898595625, 942.8868535775682, 943.5423819447597, 944.3153713557684, 944.5324564340626, 781.1134362498576, 794.8489786940492, 912.1699253679153, 926.703454894434, 929.7675581104724, 690.7893092606753, 690.7962151165368, 691.0981169573704, 693.2409012131708, 696.0012382231514, 13983.37074831635, 14315.212663303515, 14337.06809057408, 14367.066140700925, 14376.137431754129, 12379.62861114168, 12890.80663790044, 13054.608361749162, 13065.869341306561, 13087.411066501934, 10394.22043346752, 10948.507317170746, 11098.0, 11110.944445277722, 11723.765524689543, 3890.7665540067687, 3905.882823515299, 3930.2728995135703, 3961.841526338972, 3972.245273398045, 45312.546874531494, 51467.227991580156, 52152.21771673428, 52189.21716174261, 52388.0, 10104.0, 10183.490825458697, 10550.314229575053, 10668.413237271869, 10924.726881827859, 17888.731669024713, 17895.642087158445, 17901.28394864217, 17909.28362865497, 17965.281388744566, 6421.0, 6535.313792051861, 6544.149260596092, 6550.868982620416, 6651.501137414713, 4579.496255411902, 4642.837500687528, 4670.439547254351, 4733.242681171065, 4745.383100197021, 3201.055688571877, 3210.3258315753487, 3225.419424503565, 3232.111169428426, 3239.481682930767, 590.9911351329733, 593.9287285525764, 594.9791757288474, 595.6991719181872, 621.3227581935712, 650.7559665125578, 695.58265040975, 695.9756408525677, 723.4429489293215, 736.9963150184215, 8231.259186673227, 8430.620622072021, 8695.565221738887, 9526.523673816282, 9661.372010819274, 528.9444608316071, 588.2294194605081, 708.2987842036347, 716.0082539840307, 747.2873469306383, 4380.364847097153, 4420.138073075719, 4423.623991960655, 4429.623482004065, 4443.266860967969, 55782.44217557772, 55881.720591396785, 56302.15546766802, 56493.71753141208, 56532.43467565354, 51340.74329628328, 51645.48354516482, 52224.73887630613, 52228.47771522236, 52748.20877686838, 46820.0, 47363.76318118387, 47621.28568071482, 48078.0, 48215.27677084847, 8413.579321034047, 8487.0, 8592.570371481275, 8833.29333653319, 8834.911650883667, 34292.65707342895, 35336.82331588326, 35895.0, 36217.81891090528, 36788.63211367959, 44986.55013449954, 45114.87212819706, 45480.0, 45583.77208113938, 46783.53216467792, 11560.364179970182, 11826.231294965799, 11883.881161188623, 11892.940535297268, 12152.57465988686, 11683.299002059903, 12032.318210068366, 12074.577389791315, 12239.449224785085, 12399.814002789784, 11750.118741094622, 11852.76294474123, 11872.347020913932, 11894.167408281337, 12032.699182520157, 12074.094442916641, 12084.154109212623, 12095.092868034757, 12197.268163910194, 12347.38263086824, 9272.692115088284, 10044.899551004688, 11596.652100437, 12084.214526055779, 12555.43500542496, 10155.441450720282, 10319.535620896928, 10635.255532112678, 10666.480271205533, 10796.622118225825, 10283.280170388001, 10504.737381565523, 10532.684019479428, 10564.524596393334, 10595.94702026485], "unit": "ms", "name": "yui.html", "value": 6602.251188306664}], "name": "dromaeo_css", "value": 7114.224134188318}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 112.0, 110.0, 110.0, 100.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 150.0, 160.0, 127.0, 150.0, 152.0, 132.0, 161.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 159.0, 159.0, 159.0, 163.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 152.0, 72.0, 72.0, 72.0, 73.0, 147.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 92.0, 93.0, 93.0, 144.0, 92.0, 93.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.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, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 57.0, 57.0, 58.0, 59.0, 58.0, 56.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 70.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [84.0, 75.0, 77.0, 78.0, 79.0, 79.0, 78.0, 79.0, 77.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 110.0, 116.0, 121.0, 112.0, 121.0, 118.0, 111.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [136.0, 147.0, 152.0, 144.0, 146.0, 140.0, 148.0, 146.0, 159.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 67.0, 64.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1483.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.8608470181504], "unit": "score", "name": "Richards", "value": 204.22207000000006}, {"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "DeltaBlue", "value": 399.41883800000005}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [574.7126436781609], "unit": "score", "name": "Earley", "value": 1159.6456199999998}, {"lowerIsBetter": false, "replicates": [10589.473684210527], "unit": "score", "name": "Boyer", "value": 62.93636679920471}, {"lowerIsBetter": false, "replicates": [24390.243902439026], "unit": "score", "name": "RegExp", "value": 37.350384999999974}, {"lowerIsBetter": false, "replicates": [524.3838489774515], "unit": "score", "name": "Splay", "value": 155.40333699999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23063.348350038497}]} 11:04:15 INFO - RETURN: dromaeo_css: 7114.22 11:04:15 INFO - RETURN: kraken: 1483.10 11:04:15 INFO - RETURN: v8_7: 23063.35 11:04:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23063.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1483.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7114.22"}}} 11:04:15 INFO - Return code: 0 11:04:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:04:15 INFO - # TBPL SUCCESS # 11:04:15 INFO - Running post-action listener: _resource_record_post_action 11:04:15 INFO - Running post-run listener: _resource_record_post_run 11:04:16 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510296064; Read time: 52; Write time: 800636 11:04:16 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 229490688; Read time: 0; Write time: 576424 11:04:16 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263692288; Read time: 52; Write time: 219296 11:04:16 INFO - Running post-run listener: _upload_blobber_files 11:04:16 INFO - Blob upload gear active. 11:04:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:04:16 INFO - Copying logs to upload dir... 11:04:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.284770 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-25 11:04:16.205139) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-25 11:04:16.215701) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010008 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456418126/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-25 11:04:16.240220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 11:04:16.240559) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1456425692.107842-841882796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 11:04:16.456565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 11:04:16.456902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 11:04:16.457188) ========= ========= Total master_lag: 0.45 =========