builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1453682475.59 results: success (0) buildid: 20160124133014 builduid: 5790e3f77ba3414987970f37284314a8 revision: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.587507) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.588011) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.588332) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006325 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.626345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.626695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.725119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.725418) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.783317) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.783634) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.784050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.784612) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 16:41:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-24 16:41:16 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098771 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.909195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:15.909587) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.143357 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.070678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.071157) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 --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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 16:41:16,828 truncating revision to first 12 chars 2016-01-24 16:41:16,828 Setting DEBUG logging. 2016-01-24 16:41:16,828 attempt 1/10 2016-01-24 16:41:16,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2256ee8ae9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 16:41:17,082 unpacking tar archive at: mozilla-central-c2256ee8ae9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.635249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.635618) ========= echo c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7'] 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 program finished with exit code 0 elapsedTime=0.004588 script_repo_revision: 'c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.696239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.696673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 16:41:16.713583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-24 16:41:16.713915) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:41:17 INFO - MultiFileLogger online at 20160124 16:41:17 in /builds/slave/test-pgo 16:41:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:41:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:41:17 INFO - {'append_to_log': False, 16:41:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:41:17 INFO - 'blob_upload_branch': 'Firefox', 16:41:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:41:17 INFO - 'branch': 'Firefox', 16:41:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:17 INFO - 'config_files': ('talos/linux_config.py',), 16:41:17 INFO - 'default_actions': ('clobber', 16:41:17 INFO - 'read-buildbot-config', 16:41:17 INFO - 'download-and-extract', 16:41:17 INFO - 'populate-webroot', 16:41:17 INFO - 'create-virtualenv', 16:41:17 INFO - 'install', 16:41:17 INFO - 'run-tests'), 16:41:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:17 INFO - 'download_minidump_stackwalk': True, 16:41:17 INFO - 'download_symbols': 'ondemand', 16:41:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:17 INFO - 'installer_path': 'installer.exe', 16:41:17 INFO - 'log_level': 'info', 16:41:17 INFO - 'log_name': 'talos', 16:41:17 INFO - 'log_to_console': True, 16:41:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:41:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:41:17 INFO - 'opt_config_files': (), 16:41:17 INFO - 'pip_index': False, 16:41:17 INFO - 'sps_profile': False, 16:41:17 INFO - 'sps_profile_interval': 0, 16:41:17 INFO - 'suite': 'dromaeojs-e10s', 16:41:17 INFO - 'system_bits': '32', 16:41:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:17 INFO - 'title': 'talos-linux64-ix-029', 16:41:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:17 INFO - 'use_talos_json': True, 16:41:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:41:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:17 INFO - 'work_dir': 'build'} 16:41:17 INFO - ##### 16:41:17 INFO - ##### Running clobber step. 16:41:17 INFO - ##### 16:41:17 INFO - Running pre-action listener: _resource_record_pre_action 16:41:17 INFO - Running main action method: clobber 16:41:17 INFO - rmtree: /builds/slave/test-pgo/build 16:41:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:41:18 INFO - Running post-action listener: _resource_record_post_action 16:41:18 INFO - ##### 16:41:18 INFO - ##### Running read-buildbot-config step. 16:41:18 INFO - ##### 16:41:18 INFO - Running pre-action listener: _resource_record_pre_action 16:41:18 INFO - Running main action method: read_buildbot_config 16:41:18 INFO - Using buildbot properties: 16:41:18 INFO - { 16:41:18 INFO - "project": "", 16:41:18 INFO - "product": "firefox", 16:41:18 INFO - "script_repo_revision": "production", 16:41:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:41:18 INFO - "repository": "", 16:41:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:41:18 INFO - "buildid": "20160124133014", 16:41:18 INFO - "pgo_build": "True", 16:41:18 INFO - "basedir": "/builds/slave/test-pgo", 16:41:18 INFO - "buildnumber": 84, 16:41:18 INFO - "slavename": "talos-linux64-ix-029", 16:41:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:41:18 INFO - "platform": "ubuntu64_hw", 16:41:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:41:18 INFO - "branch": "mozilla-central", 16:41:18 INFO - "repo_path": "mozilla-central", 16:41:18 INFO - "revision": "c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7", 16:41:18 INFO - "stage_platform": "linux64-pgo", 16:41:18 INFO - "builduid": "5790e3f77ba3414987970f37284314a8", 16:41:18 INFO - "slavebuilddir": "test" 16:41:18 INFO - } 16:41:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:41:18 INFO - Running post-action listener: _resource_record_post_action 16:41:18 INFO - ##### 16:41:18 INFO - ##### Running download-and-extract step. 16:41:18 INFO - ##### 16:41:18 INFO - Running pre-action listener: _resource_record_pre_action 16:41:18 INFO - Running main action method: download_and_extract 16:41:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:41: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')]} 16:41:18 INFO - https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/test_packages.json 16:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/test_packages.json 16:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:41:21 INFO - Downloaded 1448 bytes. 16:41:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:41:21 INFO - Using the following test package requirements: 16:41:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:41:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:41:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:41:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'jsshell-linux-x86_64.zip'], 16:41:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:41:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:41:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:41:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:41:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:41:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:41:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:41:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:41: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')]} 16:41:21 INFO - https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:41:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:41:26 INFO - Downloaded 22491927 bytes. 16:41:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:41:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:41:27 INFO - Return code: 0 16:41:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:41:27 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')]} 16:41:27 INFO - https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:41:29 INFO - Downloaded 22491927 bytes. 16:41:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:41:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:41:31 INFO - Return code: 0 16:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:31 INFO - https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:41:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:41:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:41:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:41:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:41:32 INFO - Downloaded 10706572 bytes. 16:41:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:41:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:41:32 INFO - Return code: 0 16:41: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')]} 16:41:32 INFO - https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:41:33 INFO - Downloaded 55988405 bytes. 16:41:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:41:33 INFO - mkdir: /builds/slave/test-pgo/properties 16:41:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:41:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:41:33 INFO - Contents: 16:41:33 INFO - build_url:https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:41:33 INFO - Running post-action listener: _resource_record_post_action 16:41:33 INFO - Running post-action listener: set_extra_try_arguments 16:41:33 INFO - ##### 16:41:33 INFO - ##### Running populate-webroot step. 16:41:33 INFO - ##### 16:41:33 INFO - Running pre-action listener: _resource_record_pre_action 16:41:33 INFO - Running main action method: populate_webroot 16:41:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:41:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:41:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:41:33 INFO - '--tppagecycles', 16:41:33 INFO - '7'], 16:41:33 INFO - 'tests': ['tsvgm']}}, 16:41:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:41:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:41:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:41:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:41:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'tests': ['damp', 'tps']}, 16:41:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['damp', 'tps']}, 16:41:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:41:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:41:33 INFO - 'other': {'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'other_l64': {'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'other_nol64': {'tests': ['a11yr', 16:41:33 INFO - 'ts_paint', 16:41:33 INFO - 'tpaint', 16:41:33 INFO - 'sessionrestore', 16:41:33 INFO - 'sessionrestore_no_auto_restore']}, 16:41:33 INFO - 'svgr': {'tests': ['tsvgx', 16:41:33 INFO - 'tsvgr_opacity', 16:41:33 INFO - 'tart', 16:41:33 INFO - 'tscrollx', 16:41:33 INFO - 'cart']}, 16:41:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['tsvgx', 16:41:33 INFO - 'tsvgr_opacity', 16:41:33 INFO - 'tart', 16:41:33 INFO - 'tscrollx', 16:41:33 INFO - 'cart']}, 16:41:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'tests': ['tp5o']}, 16:41:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'talos_options': ['--e10s'], 16:41:33 INFO - 'tests': ['tp5o']}, 16:41:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'talos_options': ['--xperf_path', 16:41:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:33 INFO - 'tests': ['tp5n']}, 16:41:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:33 INFO - 'talos_options': ['--e10s', 16:41:33 INFO - '--xperf_path', 16:41:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:33 INFO - 'tests': ['tp5n']}}, 16:41:33 INFO - 'talos.zip': {'path': '', 16:41:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:41:33 INFO - Running post-action listener: _resource_record_post_action 16:41:33 INFO - ##### 16:41:33 INFO - ##### Running create-virtualenv step. 16:41:33 INFO - ##### 16:41:33 INFO - Running pre-action listener: _resource_record_pre_action 16:41:33 INFO - Running main action method: create_virtualenv 16:41:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:41:33 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 16:41:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:41:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:41:33 INFO - Using real prefix '/usr' 16:41:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:41:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:41:36 INFO - Installing pip.................done. 16:41:36 INFO - Return code: 0 16:41:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:41:36 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')]} 16:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:36 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')]} 16:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:36 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:36 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 16:41:36 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 16:41:36 INFO - Using env: {'DISPLAY': ':0', 16:41:36 INFO - 'HOME': '/home/cltbld', 16:41:36 INFO - 'LANG': 'en_US.UTF-8', 16:41:36 INFO - 'LANGUAGE': 'en_US:en', 16:41:36 INFO - 'LOGNAME': 'cltbld', 16:41:36 INFO - 'MAIL': '/var/mail/cltbld', 16:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:36 INFO - 'MOZ_NO_REMOTE': '1', 16:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:36 INFO - 'NO_EM_RESTART': '1', 16:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:36 INFO - 'SHELL': '/bin/bash', 16:41:36 INFO - 'SHLVL': '1', 16:41:36 INFO - 'TERM': 'linux', 16:41:36 INFO - 'TMOUT': '86400', 16:41:36 INFO - 'USER': 'cltbld', 16:41:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:36 INFO - '_': '/tools/buildbot/bin/python'} 16:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:36 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 16:41:36 INFO - Cleaning up... 16:41:36 INFO - Return code: 0 16:41:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:41:36 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')]} 16:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:36 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')]} 16:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:36 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:36 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 16:41:36 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 16:41:36 INFO - Using env: {'DISPLAY': ':0', 16:41:36 INFO - 'HOME': '/home/cltbld', 16:41:36 INFO - 'LANG': 'en_US.UTF-8', 16:41:36 INFO - 'LANGUAGE': 'en_US:en', 16:41:36 INFO - 'LOGNAME': 'cltbld', 16:41:36 INFO - 'MAIL': '/var/mail/cltbld', 16:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:36 INFO - 'MOZ_NO_REMOTE': '1', 16:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:36 INFO - 'NO_EM_RESTART': '1', 16:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:36 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:36 INFO - 'SHELL': '/bin/bash', 16:41:36 INFO - 'SHLVL': '1', 16:41:36 INFO - 'TERM': 'linux', 16:41:36 INFO - 'TMOUT': '86400', 16:41:36 INFO - 'USER': 'cltbld', 16:41:36 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:36 INFO - '_': '/tools/buildbot/bin/python'} 16:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:36 INFO - Downloading/unpacking psutil>=0.7.1 16:41:36 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 16:41:36 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 16:41:36 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 16:41:36 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 16:41:36 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 16:41:36 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 16:41:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:41:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:38 INFO - Installing collected packages: psutil 16:41:38 INFO - Running setup.py install for psutil 16:41:38 INFO - building 'psutil._psutil_linux' extension 16:41:38 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 16:41:38 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 16:41:38 INFO - building 'psutil._psutil_posix' extension 16:41:38 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 16:41:38 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 16:41:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:39 INFO - Successfully installed psutil 16:41:39 INFO - Cleaning up... 16:41:39 INFO - Return code: 0 16:41:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:39 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:39 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 16:41:39 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 16:41:39 INFO - Using env: {'DISPLAY': ':0', 16:41:39 INFO - 'HOME': '/home/cltbld', 16:41:39 INFO - 'LANG': 'en_US.UTF-8', 16:41:39 INFO - 'LANGUAGE': 'en_US:en', 16:41:39 INFO - 'LOGNAME': 'cltbld', 16:41:39 INFO - 'MAIL': '/var/mail/cltbld', 16:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:39 INFO - 'MOZ_NO_REMOTE': '1', 16:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:39 INFO - 'NO_EM_RESTART': '1', 16:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:39 INFO - 'SHELL': '/bin/bash', 16:41:39 INFO - 'SHLVL': '1', 16:41:39 INFO - 'TERM': 'linux', 16:41:39 INFO - 'TMOUT': '86400', 16:41:39 INFO - 'USER': 'cltbld', 16:41:39 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:39 INFO - '_': '/tools/buildbot/bin/python'} 16:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:41:39 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 16:41:39 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 16:41:39 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 16:41:39 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 16:41:39 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 16:41:39 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 16:41:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:41:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:41:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:41:41 INFO - Installing collected packages: mozsystemmonitor 16:41:41 INFO - Running setup.py install for mozsystemmonitor 16:41:41 INFO - Successfully installed mozsystemmonitor 16:41:41 INFO - Cleaning up... 16:41:41 INFO - Return code: 0 16:41:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:41: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')]} 16:41:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:41 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:41 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 16:41:41 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 16:41:41 INFO - Using env: {'DISPLAY': ':0', 16:41:41 INFO - 'HOME': '/home/cltbld', 16:41:41 INFO - 'LANG': 'en_US.UTF-8', 16:41:41 INFO - 'LANGUAGE': 'en_US:en', 16:41:41 INFO - 'LOGNAME': 'cltbld', 16:41:41 INFO - 'MAIL': '/var/mail/cltbld', 16:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:41 INFO - 'MOZ_NO_REMOTE': '1', 16:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:41 INFO - 'NO_EM_RESTART': '1', 16:41:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:41 INFO - 'SHELL': '/bin/bash', 16:41:41 INFO - 'SHLVL': '1', 16:41:41 INFO - 'TERM': 'linux', 16:41:41 INFO - 'TMOUT': '86400', 16:41:41 INFO - 'USER': 'cltbld', 16:41:41 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:41 INFO - '_': '/tools/buildbot/bin/python'} 16:41:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:41:41 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 16:41:41 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 16:41:41 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 16:41:41 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 16:41:41 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 16:41:41 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 16:41:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:41:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:41:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:41:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41: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 16:41:43 INFO - Downloading docopt-0.6.1.tar.gz 16:41:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:41:43 INFO - Installing collected packages: blobuploader, requests, docopt 16:41:43 INFO - Running setup.py install for blobuploader 16:41:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:41:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:41:44 INFO - Running setup.py install for requests 16:41:44 INFO - Running setup.py install for docopt 16:41:44 INFO - Successfully installed blobuploader requests docopt 16:41:44 INFO - Cleaning up... 16:41:44 INFO - Return code: 0 16:41:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:41:44 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')]} 16:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:44 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')]} 16:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:44 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:44 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 16:41:44 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 16:41:44 INFO - Using env: {'DISPLAY': ':0', 16:41:44 INFO - 'HOME': '/home/cltbld', 16:41:44 INFO - 'LANG': 'en_US.UTF-8', 16:41:44 INFO - 'LANGUAGE': 'en_US:en', 16:41:44 INFO - 'LOGNAME': 'cltbld', 16:41:44 INFO - 'MAIL': '/var/mail/cltbld', 16:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:44 INFO - 'MOZ_NO_REMOTE': '1', 16:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:44 INFO - 'NO_EM_RESTART': '1', 16:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:44 INFO - 'SHELL': '/bin/bash', 16:41:44 INFO - 'SHLVL': '1', 16:41:44 INFO - 'TERM': 'linux', 16:41:44 INFO - 'TMOUT': '86400', 16:41:44 INFO - 'USER': 'cltbld', 16:41:44 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:44 INFO - '_': '/tools/buildbot/bin/python'} 16:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:41:44 INFO - Running setup.py (path:/tmp/pip-AdldTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:41:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:41:44 INFO - Running setup.py (path:/tmp/pip-oUt4pv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:41:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:41:44 INFO - Running setup.py (path:/tmp/pip-EdNH6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:41:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:41:44 INFO - Running setup.py (path:/tmp/pip-SAGt2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:41:45 INFO - Running setup.py (path:/tmp/pip-g5LcR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:41:45 INFO - Running setup.py (path:/tmp/pip-ePHMNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:41:45 INFO - Running setup.py (path:/tmp/pip-KroEhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:41:45 INFO - Running setup.py (path:/tmp/pip-T6wMex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:41:45 INFO - Running setup.py (path:/tmp/pip-detOox-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:41:45 INFO - Running setup.py (path:/tmp/pip-eUyLYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:41:45 INFO - Running setup.py (path:/tmp/pip-2mGeUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:41:45 INFO - Running setup.py (path:/tmp/pip-1wsf9S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:41:45 INFO - Running setup.py (path:/tmp/pip-E_U4bq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:41:45 INFO - Running setup.py (path:/tmp/pip-cLPywc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:41:45 INFO - Running setup.py (path:/tmp/pip-ER3nsL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:41:45 INFO - Running setup.py (path:/tmp/pip-bo6Nx8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:41:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:41:45 INFO - Running setup.py (path:/tmp/pip-iC0R58-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:41:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:41:45 INFO - Running setup.py install for manifestparser 16:41:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for mozcrash 16:41:46 INFO - Running setup.py install for mozdebug 16:41:46 INFO - Running setup.py install for mozdevice 16:41:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for mozfile 16:41:46 INFO - Running setup.py install for mozhttpd 16:41:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for mozinfo 16:41:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for mozInstall 16:41:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for mozleak 16:41:46 INFO - Running setup.py install for mozlog 16:41:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:41:46 INFO - Running setup.py install for moznetwork 16:41:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Running setup.py install for mozprocess 16:41:47 INFO - Running setup.py install for mozprofile 16:41:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Running setup.py install for mozrunner 16:41:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Running setup.py install for mozscreenshot 16:41:47 INFO - Running setup.py install for moztest 16:41:47 INFO - Running setup.py install for mozversion 16:41:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:41:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:41:47 INFO - Cleaning up... 16:41:47 INFO - Return code: 0 16:41:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:41:47 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')]} 16:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:47 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')]} 16:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:47 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:47 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 16:41:47 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 16:41:47 INFO - Using env: {'DISPLAY': ':0', 16:41:47 INFO - 'HOME': '/home/cltbld', 16:41:47 INFO - 'LANG': 'en_US.UTF-8', 16:41:47 INFO - 'LANGUAGE': 'en_US:en', 16:41:47 INFO - 'LOGNAME': 'cltbld', 16:41:47 INFO - 'MAIL': '/var/mail/cltbld', 16:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:47 INFO - 'MOZ_NO_REMOTE': '1', 16:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:47 INFO - 'NO_EM_RESTART': '1', 16:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:47 INFO - 'SHELL': '/bin/bash', 16:41:47 INFO - 'SHLVL': '1', 16:41:47 INFO - 'TERM': 'linux', 16:41:47 INFO - 'TMOUT': '86400', 16:41:47 INFO - 'USER': 'cltbld', 16:41:47 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:47 INFO - '_': '/tools/buildbot/bin/python'} 16:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:41:47 INFO - Running setup.py (path:/tmp/pip-pGR3Mj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:41:48 INFO - Running setup.py (path:/tmp/pip-AZzr71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:41:48 INFO - Running setup.py (path:/tmp/pip-ZUlYKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:41:48 INFO - Running setup.py (path:/tmp/pip-xNcwU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:41:48 INFO - Running setup.py (path:/tmp/pip-2PQiyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:41:48 INFO - Running setup.py (path:/tmp/pip-gT6Q8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:41:48 INFO - Running setup.py (path:/tmp/pip-Qb7CUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:41:48 INFO - Running setup.py (path:/tmp/pip-xG74dE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:41:48 INFO - Running setup.py (path:/tmp/pip-LXkmG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:41:48 INFO - Running setup.py (path:/tmp/pip-DurE0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:41:48 INFO - Running setup.py (path:/tmp/pip-Irwfsj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:41:48 INFO - Running setup.py (path:/tmp/pip-9jiqRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:41:48 INFO - Running setup.py (path:/tmp/pip-XoqTPt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:41:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:41:48 INFO - Running setup.py (path:/tmp/pip-og5Yvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:41:48 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)) 16:41:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:41:48 INFO - Running setup.py (path:/tmp/pip-BH330f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:41:49 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)) 16:41:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:41:49 INFO - Running setup.py (path:/tmp/pip-flL7RL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:41:49 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)) 16:41:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:41:49 INFO - Running setup.py (path:/tmp/pip-q_FU6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:41:49 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)) 16:41:49 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)) 16:41:49 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)) 16:41:49 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)) 16:41:49 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:41:49 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:41:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:50 INFO - Downloading blessings-1.6.tar.gz 16:41:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:41:50 INFO - Installing collected packages: blessings 16:41:50 INFO - Running setup.py install for blessings 16:41:51 INFO - Successfully installed blessings 16:41:51 INFO - Cleaning up... 16:41:51 INFO - Return code: 0 16:41:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:41:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:41:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:41:51 INFO - Reading from file tmpfile_stdout 16:41:51 INFO - Current package versions: 16:41:51 INFO - argparse == 1.2.1 16:41:51 INFO - blessings == 1.6 16:41:51 INFO - blobuploader == 1.2.4 16:41:51 INFO - docopt == 0.6.1 16:41:51 INFO - manifestparser == 1.1 16:41:51 INFO - mozInstall == 1.12 16:41:51 INFO - mozcrash == 0.16 16:41:51 INFO - mozdebug == 0.1 16:41:51 INFO - mozdevice == 0.48 16:41:51 INFO - mozfile == 1.2 16:41:51 INFO - mozhttpd == 0.7 16:41:51 INFO - mozinfo == 0.9 16:41:51 INFO - mozleak == 0.1 16:41:51 INFO - mozlog == 3.1 16:41:51 INFO - moznetwork == 0.27 16:41:51 INFO - mozprocess == 0.22 16:41:51 INFO - mozprofile == 0.28 16:41:51 INFO - mozrunner == 6.11 16:41:51 INFO - mozscreenshot == 0.1 16:41:51 INFO - mozsystemmonitor == 0.0 16:41:51 INFO - moztest == 0.7 16:41:51 INFO - mozversion == 1.4 16:41:51 INFO - psutil == 3.1.1 16:41:51 INFO - requests == 1.2.3 16:41:51 INFO - wsgiref == 0.1.2 16:41:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:41:51 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')]} 16:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:51 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')]} 16:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:51 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:51 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 16:41:51 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 16:41:51 INFO - Using env: {'DISPLAY': ':0', 16:41:51 INFO - 'HOME': '/home/cltbld', 16:41:51 INFO - 'LANG': 'en_US.UTF-8', 16:41:51 INFO - 'LANGUAGE': 'en_US:en', 16:41:51 INFO - 'LOGNAME': 'cltbld', 16:41:51 INFO - 'MAIL': '/var/mail/cltbld', 16:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:51 INFO - 'MOZ_NO_REMOTE': '1', 16:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:51 INFO - 'NO_EM_RESTART': '1', 16:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:51 INFO - 'SHELL': '/bin/bash', 16:41:51 INFO - 'SHLVL': '1', 16:41:51 INFO - 'TERM': 'linux', 16:41:51 INFO - 'TMOUT': '86400', 16:41:51 INFO - 'USER': 'cltbld', 16:41:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:51 INFO - '_': '/tools/buildbot/bin/python'} 16:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 16:41:51 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 2)) 16:41:51 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 3)) 16:41:51 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 4)) 16:41:51 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 5)) 16:41:51 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 6)) 16:41:51 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 7)) 16:41:51 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 8)) 16:41:51 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 9)) 16:41:51 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:41:51 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 4)) 16:41:51 INFO - Cleaning up... 16:41:51 INFO - Return code: 0 16:41:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:41:51 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')]} 16:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:51 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')]} 16:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:51 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:51 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 16:41:51 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 16:41:51 INFO - Using env: {'DISPLAY': ':0', 16:41:51 INFO - 'HOME': '/home/cltbld', 16:41:51 INFO - 'LANG': 'en_US.UTF-8', 16:41:51 INFO - 'LANGUAGE': 'en_US:en', 16:41:51 INFO - 'LOGNAME': 'cltbld', 16:41:51 INFO - 'MAIL': '/var/mail/cltbld', 16:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:51 INFO - 'MOZ_NO_REMOTE': '1', 16:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:51 INFO - 'NO_EM_RESTART': '1', 16:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:51 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:51 INFO - 'SHELL': '/bin/bash', 16:41:51 INFO - 'SHLVL': '1', 16:41:51 INFO - 'TERM': 'linux', 16:41:51 INFO - 'TMOUT': '86400', 16:41:51 INFO - 'USER': 'cltbld', 16:41:51 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:51 INFO - '_': '/tools/buildbot/bin/python'} 16:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:51 INFO - Downloading/unpacking jsonschema 16:41:51 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 16:41:51 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 16:41:51 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 16:41:51 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 16:41:51 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 16:41:51 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 16:41:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:41:53 INFO - Downloading/unpacking functools32 (from jsonschema) 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:41:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:41:53 INFO - warning: no files found matching '*.txt' 16:41:53 INFO - no previously-included directories found matching 'build' 16:41:53 INFO - no previously-included directories found matching 'dist' 16:41:53 INFO - no previously-included directories found matching '.git*' 16:41:53 INFO - Installing collected packages: jsonschema, functools32 16:41:53 INFO - Running setup.py install for functools32 16:41:53 INFO - warning: no files found matching '*.txt' 16:41:53 INFO - no previously-included directories found matching 'build' 16:41:53 INFO - no previously-included directories found matching 'dist' 16:41:53 INFO - no previously-included directories found matching '.git*' 16:41:53 INFO - Successfully installed jsonschema functools32 16:41:53 INFO - Cleaning up... 16:41:54 INFO - Return code: 0 16:41:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:54 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 0x7f0103c56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b09560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, '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': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', '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 16:41:54 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 16:41:54 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 16:41:54 INFO - Using env: {'DISPLAY': ':0', 16:41:54 INFO - 'HOME': '/home/cltbld', 16:41:54 INFO - 'LANG': 'en_US.UTF-8', 16:41:54 INFO - 'LANGUAGE': 'en_US:en', 16:41:54 INFO - 'LOGNAME': 'cltbld', 16:41:54 INFO - 'MAIL': '/var/mail/cltbld', 16:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:54 INFO - 'MOZ_NO_REMOTE': '1', 16:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:54 INFO - 'NO_EM_RESTART': '1', 16:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:41:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:41:54 INFO - 'SHELL': '/bin/bash', 16:41:54 INFO - 'SHLVL': '1', 16:41:54 INFO - 'TERM': 'linux', 16:41:54 INFO - 'TMOUT': '86400', 16:41:54 INFO - 'USER': 'cltbld', 16:41:54 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:54 INFO - '_': '/tools/buildbot/bin/python'} 16:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:54 INFO - Downloading/unpacking flake8 16:41:54 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 16:41:54 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 16:41:54 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 16:41:54 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 16:41:54 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 16:41:54 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 16:41:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:41:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:41:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 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 16:41:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:41:56 INFO - no previously-included directories found matching 'docs/_build' 16:41:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:41:56 INFO - Running setup.py install for pep8 16:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:41:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:41:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:41:56 INFO - no previously-included directories found matching 'docs/_build' 16:41:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:41:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:41:56 INFO - Cleaning up... 16:41:56 INFO - Return code: 0 16:41:56 INFO - Running post-action listener: _resource_record_post_action 16:41:56 INFO - Running post-action listener: _start_resource_monitoring 16:41:56 INFO - Starting resource monitoring. 16:41:56 INFO - ##### 16:41:56 INFO - ##### Running install step. 16:41:56 INFO - ##### 16:41:56 INFO - Running pre-action listener: _resource_record_pre_action 16:41:56 INFO - Running main action method: install 16:41:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:41:57 INFO - Reading from file tmpfile_stdout 16:41:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:41:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:41:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:41:57 INFO - Reading from file tmpfile_stdout 16:41:57 INFO - Output received: 16:41:57 INFO - Usage: mozinstall [options] installer 16:41:57 INFO - Options: 16:41:57 INFO - -h, --help show this help message and exit 16:41:57 INFO - -d DEST, --destination=DEST 16:41:57 INFO - Directory to install application into. [default: 16:41:57 INFO - "/builds/slave/test-pgo"] 16:41:57 INFO - --app=APP Application being installed. [default: firefox] 16:41:57 INFO - mkdir: /builds/slave/test-pgo/build/application 16:41:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:41:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:42:13 INFO - Reading from file tmpfile_stdout 16:42:13 INFO - Output received: 16:42:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:42:13 INFO - Running post-action listener: _resource_record_post_action 16:42:13 INFO - ##### 16:42:13 INFO - ##### Running run-tests step. 16:42:13 INFO - ##### 16:42:13 INFO - Running pre-action listener: _resource_record_pre_action 16:42:13 INFO - Running main action method: run_tests 16:42:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:42:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:42:13 INFO - Python 2.7.3 16:42:13 INFO - Return code: 0 16:42:13 INFO - grabbing minidump binary from tooltool 16:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:13 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 0x2b98740>, '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 0x2b99640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b99af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:42:13 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 16:42:13 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 16:42:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:42:13 INFO - Return code: 0 16:42:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:42:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:42:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:42:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:42:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:42:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:42:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:42:14 INFO - Return code: 0 16:42:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:42:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:42:14 INFO - Using env: {'DISPLAY': ':0', 16:42:14 INFO - 'HOME': '/home/cltbld', 16:42:14 INFO - 'LANG': 'en_US.UTF-8', 16:42:14 INFO - 'LANGUAGE': 'en_US:en', 16:42:14 INFO - 'LOGNAME': 'cltbld', 16:42:14 INFO - 'MAIL': '/var/mail/cltbld', 16:42:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:42:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:14 INFO - 'MOZ_NO_REMOTE': '1', 16:42:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:14 INFO - 'NO_EM_RESTART': '1', 16:42:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:42:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:42:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:42:14 INFO - 'SHELL': '/bin/bash', 16:42:14 INFO - 'SHLVL': '1', 16:42:14 INFO - 'TERM': 'linux', 16:42:14 INFO - 'TMOUT': '86400', 16:42:14 INFO - 'USER': 'cltbld', 16:42:14 INFO - 'XDG_SESSION_COOKIE': '0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643', 16:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:14 INFO - '_': '/tools/buildbot/bin/python'} 16:42:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:42:14 INFO - mozversion application_buildid: 20160124133014 16:42:14 INFO - mozversion application_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:42:14 INFO - mozversion application_display_name: Nightly 16:42:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:42:14 INFO - mozversion application_name: Firefox 16:42:14 INFO - mozversion application_remotingname: firefox 16:42:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:42:14 INFO - mozversion application_vendor: Mozilla 16:42:14 INFO - mozversion application_version: 46.0a1 16:42:14 INFO - mozversion platform_buildid: 20160124133014 16:42:14 INFO - mozversion platform_changeset: c2256ee8ae9a8ee0bf7ab49a8b1924720d846cc7 16:42:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:42:14 INFO - mozversion platform_version: 46.0a1 16:42:14 INFO - using testdate: 1453682534 16:42:14 INFO - actual date: 1453682534 16:42:14 INFO - starting webserver on 'localhost:33220' 16:42:14 INFO - SUITE-START | Running 3 tests 16:42:14 INFO - TEST-START | dromaeo_css 16:42:14 INFO - operating with platform_type : linux_ 16:42:14 INFO - Initialising browser for dromaeo_css test... 16:42:14 INFO - TEST-INFO | started process 5567 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5HxnIO/profile http://localhost:33220/getInfo.html) 16:42:18 INFO - PROCESS | 5567 | 16:42:18 INFO - PROCESS | 5567 | (process:5650): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:42:18 INFO - PROCESS | 5567 | __metrics Screen width/height:1600/1200 16:42:18 INFO - PROCESS | 5567 | colorDepth:24 16:42:18 INFO - PROCESS | 5567 | Browser inner width/height: 1024/697 16:42:18 INFO - PROCESS | 5567 | __metrics 16:42:18 INFO - PROCESS | 5567 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:42:19 INFO - TEST-INFO | 5567: exit 0 16:42:19 INFO - Browser initialized. 16:42:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:42:19 INFO - TEST-INFO | started process 5699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5HxnIO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:20 INFO - PROCESS | 5699 | 16:42:20 INFO - PROCESS | 5699 | (process:5756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:42:31 INFO - PROCESS | 5699 | RSS: Main: 151240704 16:42:31 INFO - PROCESS | 5699 | 16:43:21 INFO - PROCESS | 5699 | 1453682601046 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] 16:45:29 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33220/tests/dromaeo/cssquery-ext.html) 16:45:30 INFO - PROCESS | 5699 | RSS: Main: 160813056 16:45:30 INFO - PROCESS | 5699 | 16:48:32 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-ext.html (next: http://localhost:33220/tests/dromaeo/cssquery-jquery.html) 16:48:33 INFO - PROCESS | 5699 | RSS: Main: 154959872 16:48:33 INFO - PROCESS | 5699 | 16:51:35 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33220/tests/dromaeo/cssquery-mootools.html) 16:51:35 INFO - PROCESS | 5699 | RSS: Main: 156139520 16:51:35 INFO - PROCESS | 5699 | 16:54:37 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33220/tests/dromaeo/cssquery-prototype.html) 16:54:37 INFO - PROCESS | 5699 | RSS: Main: 154046464 16:54:37 INFO - PROCESS | 5699 | 16:57:40 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33220/tests/dromaeo/cssquery-yui.html) 16:57:40 INFO - PROCESS | 5699 | RSS: Main: 155811840 16:57:40 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | Cycle 1(1): loaded http://localhost:33220/tests/dromaeo/cssquery-yui.html (next: http://localhost:33220/tests/dromaeo/cssquery-dojo.html) 17:00:43 INFO - PROCESS | 5699 | RSS: Main: 158216192 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | __start_tp_report 17:00:43 INFO - PROCESS | 5699 | _x_x_mozilla_page_load 17:00:43 INFO - PROCESS | 5699 | _x_x_mozilla_page_load_details 17:00:43 INFO - PROCESS | 5699 | |i|pagename|runs| 17:00:43 INFO - PROCESS | 5699 | |0;dojo.html;3223.3553289342135;3227.596550431196;3262.200760813601;3283.2940917702695;3288.177955511122;5204.739763011853;5373.194020896867;5393.757280922353;5398.865028374293;5419.1058475351565;5334.653247538917;5365.141577347626;5371.623986320949;5383.407825139231;5392.245085688007;4894.265860120992;4898.926516102261;4967.826126085588;4998.2002879539095;5002.974985125069;772.449647005046;4854.17479028566;4880.292357608145;4883.706977581339;4922.729249891255;4839.903201935959;4849.369581954341;4873.098476781789;4897.7795999180125;4898.363212782351;4869.975650121727;4885.56029957302;4890.0953323634885;4897.730624815634;4947.134251505972;4800.447948485899;4878.536539028786;4890.0953323634885;4909.140900342426;4942.530459606368;5153.123968925292;5218.739063046833;5249.580033597303;5254.08053590624;5263.6578622389425;5676.460736230051;5696.430356964271;5702.201691763156;5719.542436605103;5733.197352370671;5682.971585142048;5749.856253593652;5771.797987070432;5772.3361813391575;5785;5346.786128554853;5392.137258038695;5407.486288802557;5407.621466497308;5446.645968012067;5861.384554621789;5874.882502350015;5879.176915231871;5881.970655135334;5882.617629854046;5556.16657501378;5586.944130558642;5588;5666.575006874501;5673.432656734293;5698.487136157766;5811.912821307684;5818.156367326714;5837.854053648693;5865.618734782225;5654.547636189095;5665.178549110356;5712.800051998243;5731.885362292731;5737.053386191315;5603.327600687943;5697.686627235542;5700.8859822803315;5723.055695810228;5740.827775166752;4482.417285752831;4487.394201782718;4497.415336006298;4519.796609152596;4527.411436513232;4014.6988975826343;4022.6178513041214;4029.6977726670616;4034.3948407739076;4046.0289530512464;5241.868953276123;5272;5385.192221166856;5387.865303367369;5426.484483974016;5747.597668163272;5761.366249712528;5788.5369170466265;5800.854978625568;5838.883222335529;5361;5369.677819330853;5391.541718953855;5395.62230643859;5407.324084489439;4804.471508134103;4852.344933434012;4908.435529914034;4946.62900282473;4978.327925730053;5885.911711324334;5957.4638282553915;6003.309619393738;6047.395260474005;6055.303640081447;5759.366469688414;5766.163906233656;5774.942250577608;5782.45066718661;5802.767889284381;5865.354810970704;6001.339852616296;6008.279006519071;6009.308929472992;6014.308354539284;5576.024195765806;5631.521320687623;5633.957717822216;5641.943580564306;5731;5777;5803.622764520293;5814.534837212928;5821.068629019336;5874.206982057368;5686.09022556389;5686.914696279642;5692.8576785579035;5702.857428564153;5704.429557044263;5407.7025763581805;5561.721913904369;5577.051901176891;5585.748641311232;5696.743646535833;5525.861853453695;5536.169574563848;5581.888362232814;5602.943970560243;5628.493435590816;5652.180433837153;5656.6888821115235;5670.546356291569;5693.601447898607;5703.230063941315;5365.195220716768;5415.106507426231;5463.53559947393;5555.72221388937;5588.189712491585 17:00:43 INFO - PROCESS | 5699 | |1;ext.html;506.7947481270085;516.4680379209414;517.9922301165485;527.9208118782183;542.1840130603441;35925.28149437013;36211.456828147566;36398.63601363986;36439.271214575696;36524.81737591315;38685;39129;39531.604683953155;39548.40677389834;39579.802100989524;8341.499510029387;8518.957405212996;8564.057953625097;8606.612702428374;8619.094995025525;8294.917050829476;8406.28546573542;8417.915820841774;8621.18098780618;8654.48073115612;8624.870626940601;8659.393842431033;8684.782880427976;8691.435056721324;8705.956470217672;8562.529060901648;8608.612612432456;8611.181937715939;8615.698450554262;8670.52312122833;8395.454295470774;8469.280111190556;8486.448380855225;8488.53313067781;8561.614727337284;38959;39570.80214598937;39671.80164099161;39781;39781.40327895084;2682.8256163349515;3161.525771134325;3169.524571314298;3183.2996740717003;3556.7332450066347;26866.731332686813;27380;28306.575401368995;29131.563026554617;29955.850220748758;3173.127389967777;3179.984100079508;3272.296456261915;3296.159479332755;3366.6801653842845;209414;209543.95228023914;210640;211118;212083;53744;54467.45532544703;60279;63269;64326.35673643297;55318.17022744662;55379.72310138504;55429.1685624716;55470;55835.44164558302;15763.842361576237;15854.207289635473;15953.202339882959;15999.120048397217;16000.359985600446;11992.760144797056;12020.879791202151;12083.275003499819;12121.575744848888;12197.634070977885;20353;20421;20492;20519.8974005132;20626.58746825055;7495.138059123162;7800.5709685966685;7810.843783124419;7817.726379576801;7846.568438735924;920.742192186189;933.026648638139;970.9708708738749;1054.752133248686;1074.984139987704;29262.414751705273;29332.706672932996;29616.111516654535;29821.85089074541;30642.846785765927;982.7150126463389;1024.902634249745;1030.1449796668746;1060.6446840308583;1073.7047311989108;14024.825438338004;14148.43406263738;14327.78508322376;14415.78376324356;14474.855251447561;382313;389960;390418;391545;392929;53579.40883892282;53682.73158634182;53938.19092713612;53945.73027134917;54362.45637543653;1323.3383308345826;1333.0468714868916;1334.2328161307094;1336.8729970652773;1353.5465619017739;26937.86531067332;27261.182164535097;27569.862150689118;27836;28092.85953570219;44230;44497.55502445064;44592;44743.328850066624;45009.77495112504;291297;292010.5399472989;293290;293726;294356;33263.66736332606;43253;43353.56646433495;43977;44376.2249510016;39042.414363783995;39449.40825887671;40417.39373909335;42831;43599.56400435955;36278;36338;37136.25727485489;38482.42276365801;39427.40858887062;35418.8229058853;36519.81740091283;37397.81301093477;37410.064748381505;38316.61683383131;33229.16927076843;34064;34097.48853767146;38315.42526862155;38801.417978730904;28991.710082898902;30861.38277234398;33517.32965340728;33621;33722;25167.49665006653;25195.24414267575;25202.747972520774;25284.241472755846;25552.744472555038 17:00:43 INFO - PROCESS | 5699 | |2;jquery.html;353.4027493535924;358.19585031604043;358.6216541548666;359.2312451354101;366.54914455220097;11021.724456888582;11533.365664888448;15390.769138462932;16049.438269660564;16994.150292485374;16749.748753768705;16950;17063.48809535716;17177.57056073599;17198;5556.138798486231;5927.496162826165;5933.673647949361;5948.672822994734;5964.761409543635;5719.914201286984;5839;5894.322152952401;5953.493953013977;5969.88060238795;5924.1113832924975;5937.317208521033;5983.1025346197985;6233;6489.513286503531;6375.872482550346;6401.583897046677;6417.518686098561;6507.219133703986;6715.992601109872;6323.968380158116;6483.351664833479;6501.869962600722;6506.54454188207;6513.413792758627;21064.5787084259;21746.56506869854;21759.67360489594;21799.564008719735;22193.334199974026;2275.4615533144233;2289.107248173197;2341.613633750429;2370.988145059281;2456.5578195924727;12663.936680316632;13180.6704832379;13488.39302231402;13733.931330343385;14002.0898641589;1768.8408043276038;1858.656148612511;1921.4331772127116;1956.7749708783388;2013.114229738925;51010;52377.7381113092;53172.73413632907;53341;53730.194047089324;14423.639409014859;14427;14475.710485790225;14853.777193342108;15045.774313385307;12751.48994040228;13139.934300328629;13179.53871614508;23067.769322306896;23237.18669846581;7062.929370706227;7351;7643.388528917673;7673.309402153833;7678.692852285958;7445.329920307198;7470.626468676544;7472.215417381205;7490.475666703279;7554.2823431773895;4456.62118719906;4466.307722303049;4477.6417886569;4486.484054333728;4507.909841803145;1818.7908390534992;1819.8353054045422;1851.3057603398724;1868.9813101869079;1891.3569386408412;952.9904700953041;967.3277072434731;997.396575072071;1033.6692258477215;1050.873895132589;15113.697726045417;15424.228788560527;15646;15690.529284121494;16337.673246535003;885.2740752582949;945.3618807305041;949.6486300069018;989.8564708117283;1014.2747935226348;8608;8947.642094316285;9254.213391861767;9544.141027307576;9633;470139;470618.4098033617;472427;484790;490155;67439.32560674429;69437;69792.65103674449;70810.2918970814;71031;1130.4121856634667;1134.9886501134883;1164.7728692904802;1185.8991985681141;1189.6668932698858;14255.857441425867;14737.484188053366;14930.701385972003;15000.774988374966;15013.474528391454;29296.853515732284;29915.102546923627;30124.54813177848;30429.239269018453;30925.134358205225;37524.249515010095;37913.2149115828;38274.80862595669;42168.1566368677;42836.14327713366;7257.673404696696;7375.373093286916;7481.438892083007;7536.660850261861;7585;9401.435913845191;10740.30188037775;10931.234813562975;11124.499397526968;11181.944090279496;8075.838483230185;8324.958375208085;9472.100150485692;9532.618695252113;9583.808323833346;8971.461712297283;9116.954415228147;9270.53647317618;9397.859032114387;9731.367461115005;9523.23814094857;9587.137157655565;9729.951350243204;9768.316217864682;9947;7582.317591416799;7635.732749353746;7724.343430808444;7805.102413222325;7808.453408261367;8636.524991125549;9856.655017074369;9959.502024898582;9998.25013124004;10056.346337488332 17:00:43 INFO - PROCESS | 5699 | |3;mootools.html;1432.376916041522;1458.4822388052244;1575.4958413307745;1691.4840973503076;1717.2615775216652;7618.085829700437;7659.923400766004;7775.028121484815;7792.337651299639;7794.49335793173;7800.141984381714;7827.960860195691;7841.372690184771;7909.1299957004685;7916.881246781303;2109.0825490911425;2137.177186783092;2138.4440045588103;2139.871607703543;2143.8177754890776;2127.8723276603378;2146.957060858782;2160.0603737374213;2173.880436575988;2184.071769497965;2108.841836862234;2124.9468763280966;2133.797289257518;2169.8481106322565;2170.9565808683815;2186.7157269554855;2191.5726433345503;2201.6147174244525;2209.9668504972437;2218.2125345502277;2210.3700445372992;2212.8451008429415;2218.8557743746605;2225.365770755327;2236.7204099487562;7813.570253636048;7815.8436831263625;7843.764687059397;7871.409644276702;7895.526268423855;4678.812847486097;4778.737169455679;4812.302216178669;4813.278008298748;4817.662763606549;2872.439874224527;2958.1273524310163;2971.806832555877;2976.7618590512707;2997.2357048952376;938.5354249646468;978.232087811072;994.1847684898386;1008.6822650865028;1040.0483557544837;10602.946985265102;10645.84031239532;10649.57401703931;10651.307665001828;10679.83980240297;4037.212743515045;4082.9183416331507;4111.8560850370695;4133.793310334471;4145.79271036447;8633.611487482953;8777.297816174818;8785.912140878638;8803.251723603438;8821.823563528822;4555.863324100283;4562.5665561771575;4565.223911934979;4575.9084818303445;4591.9081618367445;4171.749695018309;4174.666026717855;4196.265653510623;4197.8320867165585;4241.957580424218;3220.822854742965;3275.394052100369;3346.832658367072;3350.916227094342;3358.3619112368574;1049.2026060194307;1050.1965996013057;1053.1311667874033;1074.2963358999868;1075.8977897099762;917.9082091790901;975.3026585990908;1122.6519778868576;1177.1144278606964;1335.8129861819352;7279.927200727925;7400.185979542353;7436.73971410998;7441.776746697607;7474.887876681854;631.0691729698749;644.6100109433725;645.2096182176796;645.7287939065603;777.7005852746734;5626.465485778845;5648.51987581052;5758.62568933018;5784.248047753765;5797.855053623609;9292.488913109844;9546.284028697737;9562.043795620382;9585.424874507551;9595.376300540582;9046.959599645994;9143.954280228689;9148.222401095849;9155.725328240163;9316.114969077928;7311.707531698778;7388.076490438695;7399.519031262951;7406.148292946273;7476.887846682304;7259.165196002527;7544.396448284015;7602.277783610548;7623.237676232332;7632.274933881273;8191.918080819116;8337.416380853281;8438.915610843813;8556.871646925425;8588.957055214683;8465.28045116172;8640.697575584825;8681.869771953552;8699.695510657097;8747.16901894319;6916.446684265347;7492.100947886289;7544.207858175032;7588.734394296173;7633.084029916446;7181.820454488679;7215.747448839265;7218.133823941161;7221.386182174364;7221.638918054181;6865.313468653295;6876.346747059021;6889.242183359726;7036.155661320674;7089.042979197742;6521.5108866834225;6631.469482441296;6660.900086498803;6708.228553716385;6883.827904302432;6635.767748128792;6718.93281067183;6749.0888730020815;6891.965540172267;6904.758333458305;6389.7763578274535;6550.803475895731;6568.80293591193;6653.334666533308;6671.299513551201;6501.8699626008165;6570.6057636540045;6573.244076931214;6581.308962559054;6599.8020059398295 17:00:43 INFO - PROCESS | 5699 | |4;prototype.html;332.9794180835739;340.884099406202;344.6243594482014;345.6508925984755;346.52526039326125;6214.658193799345;6267.341929097436;6308;6334.271558770743;6424.100625912376;6206.286277078138;6235.750569977206;6254.781082662108;6280.623162610235;6281.623102613835;4734.881627959311;4735.3370528125915;4742.976285118587;4774.259989701602;4775.832845850396;4768.856934291976;4769.189237829577;4772.188727916246;4787.688800227991;4791.089692958344;4623.797812568722;4729.668923175379;4729.692569982957;4731.78706958186;4753.144434001878;4721.645876559254;4724.858254252378;4728.621710263171;4731.290306454025;4733.479317275097;4093.6520395766397;4095.1400205956784;4098.180363927227;4098.610631989956;4108.239975604522;5941.435563621449;5964.463198312173;5967.940320596826;5991.970040149771;5992.161097446361;5407.864803379907;5517.420670829545;5519.862003449905;5541.778328866841;5546.77812887484;6584.934150658528;6630.303818099078;6644.103046088764;6660.600363978128;6684.665766711693;4516.277395616686;4532.70537415067;4539.750313732743;4547.24970379887;4561.40701708779;6787.932120678779;6871.622060786654;6888.173419189679;6891.37977582015;6957;4636.188666983265;4640.373549570832;4649.767511624405;4659.324397962277;4661.417322834645;4707.552782485658;4720.976395118002;4722.9763851181215;4727.267273572602;4731.053789242165;5478.726063696799;5484.561235101182;5485;5495.560355171577;5495.697736624444;6570.638614876228;6668.799936001928;6709.6980635871505;6776.69504872282;6779;1625.959351016234;1636.4599682104877;1661.6261341198376;1667.6664667066393;1669.8330166983205;1093.573506332531;1097.7091070866227;1101.4547798839626;1110.566878917223;1118.3737107219983;6113.5414843886;6154.599951003171;6161.507079433634;6187.81436556895;6193.535484838655;6696.86153353931;6743.696533655997;6754.290799466084;6762.932370676329;6774.593524388552;6054.152418661391;6127.295361033449;6166.5991710539565;6179.258488981351;6179.351168127282;3649.7810131392202;3656.634336566322;3667.8716244931834;3673.1551743099235;3685.557733071995;6916.20463646677;6934;6943.89584156238;6959.408450281681;6970.756023539253;6754.6284954327;6885.793426197222;6903.033575299462;6939.23668396476;6956;7030.402415794612;7050.259722729143;7062.258462861429;7077.5753454792875;7104.289571042855;6720.596764193969;6730.0241464988285;6748.831279218059;6758.493113016445;6782.253952065367;6590.538662293593;6642.535022548568;6706.865862682622;6718.596884186964;6727.562708423937;6988.650567471708;7066.328698773608;7080.079589653312;7080.398166155728;7083.787486375417;4601.44782626087;4629.629629629689;4634.351190833353;4653.929596192962;4663.650226232979;6695.899561506484;6707.731690732316;6739.359760822714;6774.390304872585;6952.5480843745;6710.932890671031;6756.898646520404;6767.593944363354;6768.593884366954;6775.966120169368;6676.198856137295;6678.866422671422;6679.298673639392;6716.126903502513;6717.093192418961;6440.098386225838;6507.609543427409;6573.57271777333;6590.7693230736695;6608.339166083353;6768.120144381199;6768.424683901727;6770.052192693125;6775.830604234737;6783.694733737092;6536.411722944958;6583.539152259296;6600.0099985002635;6605;6605.438537724347 17:00:43 INFO - PROCESS | 5699 | |5;yui.html;696.2480521037279;741.3031750154857;779.8128449172196;800.4476910931459;825.5872063968015;12472.2516649001;12540.184887982276;12552;12575.748485030304;12654.240745555273;12539.435725392357;12553.623391298253;12563.434645440955;12585.307808070553;12609.810852837192;777.3470284960632;789.4118881433326;794.5232860283842;795.6340083561569;795.6817273090752;810.2059981218409;813.4631143445328;813.6907974969504;814.7474282972297;818.0428898189103;830.2859540794911;832.3923535818856;834.7829564313262;835.1231207232412;836.6109758962082;819.1849110135454;823.9464434811748;830.0620299062022;830.4685001598981;832.1636755061155;608.9908651370233;612.7793994162098;612.788587937161;615.2524682510771;617.7065893700457;13833.861661383458;13940.16359018452;13954.372053257526;13980;13985.72028559423;12470.314132722697;12532.436040378205;12600.369981500888;12928.612141635766;12976.91227263409;10034.69895903124;10316.277860549764;10328.380297182193;10841.83737243942;10852.891471085268;3567.9108022299392;3598;3659.780413175218;3733.4959780429567;3786.8106594670157;47012.764936175445;47467.52532474665;47672.76163619194;47748.761256193495;47845.97617250208;9521.19069879068;9656.179224765832;9708.660196893075;9750.366226195416;9845.50772461374;16345.591360216089;16402.753958690628;17357.392491263;17622.118894055246;17647.823521764876;7658.617069146632;7715.498492597963;7760.146383897767;7899.960500197577;7988.400869934778;4259.637930775857;4294.954721862835;4377.124575084996;4428.31361139024;4438.844640437569;3058.877644894224;3064.417760625474;3074.216074900886;3078.9692103078683;3088.722015018659;563.3240111865778;583.0467186150674;586.6597373523347;590.2268028882178;593.9316978547436;549.9972500137474;627.7269387816223;631.5579094633774;680.6834821807884;685.3044160177424;8720.215180633773;8936.68721594754;9348.364036293622;9653.758656033655;9700.75748106303;518.4737491446185;627.6391075131818;708.5536112249353;740.1636151149274;752.8720117580025;3753.6058713834655;4215.220184265921;4241.703080784378;4329.199098166786;4411.338299255073;53353.1997020045;54321.72839135779;54493.72753136209;54832.17751733727;55541.44458555443;49064.75467622639;49122.50877491251;51207.74396127996;52530.73734631302;53548.196777048375;43460.348094779234;43471.78264108659;44030.11939761187;44481.777591112485;44850.55149448529;8764;8766.474011559327;8976.192142707188;9025.909740902507;9368.297377696565;34041.48937765985;34317.31365372628;34522;34989.650103498636;35016.82491587526;40156;41295.7935210322;41707;41790.58209417989;42866.57133428626;10762.623308184176;11040.668779936615;11287.661370158909;11512.481938312963;11676.474558644712;11567.768644626893;11576;11751.353675547927;12180.605897883497;12639.684007899508;11874;11901.166918315635;12138.635840924786;12376.381180941096;12397.690057748629;11436.085113191091;11469.713257168303;11534.59628912984;11931.403429828648;11946.522139114339;11016.889831101907;11356.034737047443;11407.543698251977;11612.010295677192;11613.245139066272;9203;9283.39657922233;9470.810583788149;9482.353646713198;9578.13796758295;9012;9067.319951003568;9191.356605037583;9853.507324633596;9887.209023278265 17:00:43 INFO - PROCESS | 5699 | __end_tp_report 17:00:43 INFO - PROCESS | 5699 | __start_cc_report 17:00:43 INFO - PROCESS | 5699 | _x_x_mozilla_cycle_collect,294 17:00:43 INFO - PROCESS | 5699 | __end_cc_report 17:00:43 INFO - PROCESS | 5699 | __startTimestamp1453683643804__endTimestamp 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | ------- Summary: start ------- 17:00:43 INFO - PROCESS | 5699 | Number of tests: 6 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#0] dojo.html Cycles:165 Average:5320.33 Median:5561.72 stddev:680.32 (12.2%) stddev-sans-first:662.21 17:00:43 INFO - PROCESS | 5699 | Values: 3223.4 3227.6 3262.2 3283.3 3288.2 5204.7 5373.2 5393.8 5398.9 5419.1 5334.7 5365.1 5371.6 5383.4 5392.2 4894.3 4898.9 4967.8 4998.2 5003.0 772.4 4854.2 4880.3 4883.7 4922.7 4839.9 4849.4 4873.1 4897.8 4898.4 4870.0 4885.6 4890.1 4897.7 4947.1 4800.4 4878.5 4890.1 4909.1 4942.5 5153.1 5218.7 5249.6 5254.1 5263.7 5676.5 5696.4 5702.2 5719.5 5733.2 5683.0 5749.9 5771.8 5772.3 5785.0 5346.8 5392.1 5407.5 5407.6 5446.6 5861.4 5874.9 5879.2 5882.0 5882.6 5556.2 5586.9 5588.0 5666.6 5673.4 5698.5 5811.9 5818.2 5837.9 5865.6 5654.5 5665.2 5712.8 5731.9 5737.1 5603.3 5697.7 5700.9 5723.1 5740.8 4482.4 4487.4 4497.4 4519.8 4527.4 4014.7 4022.6 4029.7 4034.4 4046.0 5241.9 5272.0 5385.2 5387.9 5426.5 5747.6 5761.4 5788.5 5800.9 5838.9 5361.0 5369.7 5391.5 5395.6 5407.3 4804.5 4852.3 4908.4 4946.6 4978.3 5885.9 5957.5 6003.3 6047.4 6055.3 5759.4 5766.2 5774.9 5782.5 5802.8 5865.4 6001.3 6008.3 6009.3 6014.3 5576.0 5631.5 5634.0 5641.9 5731.0 5777.0 5803.6 5814.5 5821.1 5874.2 5686.1 5686.9 5692.9 5702.9 5704.4 5407.7 5561.7 5577.1 5585.7 5696.7 5525.9 5536.2 5581.9 5602.9 5628.5 5652.2 5656.7 5670.5 5693.6 5703.2 5365.2 5415.1 5463.5 5555.7 5588.2 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#1] ext.html Cycles:180 Average:46690.62 Median:37403.94 stddev:80564.88 (215.4%) stddev-sans-first:80716.26 17:00:43 INFO - PROCESS | 5699 | Values: 506.8 516.5 518.0 527.9 542.2 35925.3 36211.5 36398.6 36439.3 36524.8 38685.0 39129.0 39531.6 39548.4 39579.8 8341.5 8519.0 8564.1 8606.6 8619.1 8294.9 8406.3 8417.9 8621.2 8654.5 8624.9 8659.4 8684.8 8691.4 8706.0 8562.5 8608.6 8611.2 8615.7 8670.5 8395.5 8469.3 8486.4 8488.5 8561.6 38959.0 39570.8 39671.8 39781.0 39781.4 2682.8 3161.5 3169.5 3183.3 3556.7 26866.7 27380.0 28306.6 29131.6 29955.9 3173.1 3180.0 3272.3 3296.2 3366.7 209414.0 209544.0 210640.0 211118.0 212083.0 53744.0 54467.5 60279.0 63269.0 64326.4 55318.2 55379.7 55429.2 55470.0 55835.4 15763.8 15854.2 15953.2 15999.1 16000.4 11992.8 12020.9 12083.3 12121.6 12197.6 20353.0 20421.0 20492.0 20519.9 20626.6 7495.1 7800.6 7810.8 7817.7 7846.6 920.7 933.0 971.0 1054.8 1075.0 29262.4 29332.7 29616.1 29821.9 30642.8 982.7 1024.9 1030.1 1060.6 1073.7 14024.8 14148.4 14327.8 14415.8 14474.9 382313.0 389960.0 390418.0 391545.0 392929.0 53579.4 53682.7 53938.2 53945.7 54362.5 1323.3 1333.0 1334.2 1336.9 1353.5 26937.9 27261.2 27569.9 27836.0 28092.9 44230.0 44497.6 44592.0 44743.3 45009.8 291297.0 292010.5 293290.0 293726.0 294356.0 33263.7 43253.0 43353.6 43977.0 44376.2 39042.4 39449.4 40417.4 42831.0 43599.6 36278.0 36338.0 37136.3 38482.4 39427.4 35418.8 36519.8 37397.8 37410.1 38316.6 33229.2 34064.0 34097.5 38315.4 38801.4 28991.7 30861.4 33517.3 33621.0 33722.0 25167.5 25195.2 25202.7 25284.2 25552.7 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#2] jquery.html Cycles:180 Average:25861.34 Median:478608.50 stddev:77927.86 (16.3%) stddev-sans-first:78122.93 17:00:43 INFO - PROCESS | 5699 | Values: 353.4 358.2 358.6 359.2 366.5 11021.7 11533.4 15390.8 16049.4 16994.2 16749.7 16950.0 17063.5 17177.6 17198.0 5556.1 5927.5 5933.7 5948.7 5964.8 5719.9 5839.0 5894.3 5953.5 5969.9 5924.1 5937.3 5983.1 6233.0 6489.5 6375.9 6401.6 6417.5 6507.2 6716.0 6324.0 6483.4 6501.9 6506.5 6513.4 21064.6 21746.6 21759.7 21799.6 22193.3 2275.5 2289.1 2341.6 2371.0 2456.6 12663.9 13180.7 13488.4 13733.9 14002.1 1768.8 1858.7 1921.4 1956.8 2013.1 51010.0 52377.7 53172.7 53341.0 53730.2 14423.6 14427.0 14475.7 14853.8 15045.8 12751.5 13139.9 13179.5 23067.8 23237.2 7062.9 7351.0 7643.4 7673.3 7678.7 7445.3 7470.6 7472.2 7490.5 7554.3 4456.6 4466.3 4477.6 4486.5 4507.9 1818.8 1819.8 1851.3 1869.0 1891.4 953.0 967.3 997.4 1033.7 1050.9 15113.7 15424.2 15646.0 15690.5 16337.7 885.3 945.4 949.6 989.9 1014.3 8608.0 8947.6 9254.2 9544.1 9633.0 470139.0 470618.4 472427.0 484790.0 490155.0 67439.3 69437.0 69792.7 70810.3 71031.0 1130.4 1135.0 1164.8 1185.9 1189.7 14255.9 14737.5 14930.7 15000.8 15013.5 29296.9 29915.1 30124.5 30429.2 30925.1 37524.2 37913.2 38274.8 42168.2 42836.1 7257.7 7375.4 7481.4 7536.7 7585.0 9401.4 10740.3 10931.2 11124.5 11181.9 8075.8 8325.0 9472.1 9532.6 9583.8 8971.5 9117.0 9270.5 9397.9 9731.4 9523.2 9587.1 9730.0 9768.3 9947.0 7582.3 7635.7 7724.3 7805.1 7808.5 8636.5 9856.7 9959.5 9998.3 10056.3 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#3] mootools.html Cycles:180 Average:5417.14 Median:6577.28 stddev:2877.77 (43.8%) stddev-sans-first:2870.26 17:00:43 INFO - PROCESS | 5699 | Values: 1432.4 1458.5 1575.5 1691.5 1717.3 7618.1 7659.9 7775.0 7792.3 7794.5 7800.1 7828.0 7841.4 7909.1 7916.9 2109.1 2137.2 2138.4 2139.9 2143.8 2127.9 2147.0 2160.1 2173.9 2184.1 2108.8 2124.9 2133.8 2169.8 2171.0 2186.7 2191.6 2201.6 2210.0 2218.2 2210.4 2212.8 2218.9 2225.4 2236.7 7813.6 7815.8 7843.8 7871.4 7895.5 4678.8 4778.7 4812.3 4813.3 4817.7 2872.4 2958.1 2971.8 2976.8 2997.2 938.5 978.2 994.2 1008.7 1040.0 10602.9 10645.8 10649.6 10651.3 10679.8 4037.2 4082.9 4111.9 4133.8 4145.8 8633.6 8777.3 8785.9 8803.3 8821.8 4555.9 4562.6 4565.2 4575.9 4591.9 4171.7 4174.7 4196.3 4197.8 4242.0 3220.8 3275.4 3346.8 3350.9 3358.4 1049.2 1050.2 1053.1 1074.3 1075.9 917.9 975.3 1122.7 1177.1 1335.8 7279.9 7400.2 7436.7 7441.8 7474.9 631.1 644.6 645.2 645.7 777.7 5626.5 5648.5 5758.6 5784.2 5797.9 9292.5 9546.3 9562.0 9585.4 9595.4 9047.0 9144.0 9148.2 9155.7 9316.1 7311.7 7388.1 7399.5 7406.1 7476.9 7259.2 7544.4 7602.3 7623.2 7632.3 8191.9 8337.4 8438.9 8556.9 8589.0 8465.3 8640.7 8681.9 8699.7 8747.2 6916.4 7492.1 7544.2 7588.7 7633.1 7181.8 7215.7 7218.1 7221.4 7221.6 6865.3 6876.3 6889.2 7036.2 7089.0 6521.5 6631.5 6660.9 6708.2 6883.8 6635.8 6718.9 6749.1 6892.0 6904.8 6389.8 6550.8 6568.8 6653.3 6671.3 6501.9 6570.6 6573.2 6581.3 6599.8 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#4] prototype.html Cycles:180 Average:5519.22 Median:6210.47 stddev:1673.26 (26.9%) stddev-sans-first:1632.04 17:00:43 INFO - PROCESS | 5699 | Values: 333.0 340.9 344.6 345.7 346.5 6214.7 6267.3 6308.0 6334.3 6424.1 6206.3 6235.8 6254.8 6280.6 6281.6 4734.9 4735.3 4743.0 4774.3 4775.8 4768.9 4769.2 4772.2 4787.7 4791.1 4623.8 4729.7 4729.7 4731.8 4753.1 4721.6 4724.9 4728.6 4731.3 4733.5 4093.7 4095.1 4098.2 4098.6 4108.2 5941.4 5964.5 5967.9 5992.0 5992.2 5407.9 5517.4 5519.9 5541.8 5546.8 6584.9 6630.3 6644.1 6660.6 6684.7 4516.3 4532.7 4539.8 4547.2 4561.4 6787.9 6871.6 6888.2 6891.4 6957.0 4636.2 4640.4 4649.8 4659.3 4661.4 4707.6 4721.0 4723.0 4727.3 4731.1 5478.7 5484.6 5485.0 5495.6 5495.7 6570.6 6668.8 6709.7 6776.7 6779.0 1626.0 1636.5 1661.6 1667.7 1669.8 1093.6 1097.7 1101.5 1110.6 1118.4 6113.5 6154.6 6161.5 6187.8 6193.5 6696.9 6743.7 6754.3 6762.9 6774.6 6054.2 6127.3 6166.6 6179.3 6179.4 3649.8 3656.6 3667.9 3673.2 3685.6 6916.2 6934.0 6943.9 6959.4 6970.8 6754.6 6885.8 6903.0 6939.2 6956.0 7030.4 7050.3 7062.3 7077.6 7104.3 6720.6 6730.0 6748.8 6758.5 6782.3 6590.5 6642.5 6706.9 6718.6 6727.6 6988.7 7066.3 7080.1 7080.4 7083.8 4601.4 4629.6 4634.4 4653.9 4663.7 6695.9 6707.7 6739.4 6774.4 6952.5 6710.9 6756.9 6767.6 6768.6 6776.0 6676.2 6678.9 6679.3 6716.1 6717.1 6440.1 6507.6 6573.6 6590.8 6608.3 6768.1 6768.4 6770.1 6775.8 6783.7 6536.4 6583.5 6600.0 6605.0 6605.4 17:00:43 INFO - PROCESS | 5699 | 17:00:43 INFO - PROCESS | 5699 | [#5] yui.html Cycles:180 Average:13540.57 Median:47240.15 stddev:15346.12 (32.5%) stddev-sans-first:15358.86 17:00:43 INFO - PROCESS | 5699 | Values: 696.2 741.3 779.8 800.4 825.6 12472.3 12540.2 12552.0 12575.7 12654.2 12539.4 12553.6 12563.4 12585.3 12609.8 777.3 789.4 794.5 795.6 795.7 810.2 813.5 813.7 814.7 818.0 830.3 832.4 834.8 835.1 836.6 819.2 823.9 830.1 830.5 832.2 609.0 612.8 612.8 615.3 617.7 13833.9 13940.2 13954.4 13980.0 13985.7 12470.3 12532.4 12600.4 12928.6 12976.9 10034.7 10316.3 10328.4 10841.8 10852.9 3567.9 3598.0 3659.8 3733.5 3786.8 47012.8 47467.5 47672.8 47748.8 47846.0 9521.2 9656.2 9708.7 9750.4 9845.5 16345.6 16402.8 17357.4 17622.1 17647.8 7658.6 7715.5 7760.1 7900.0 7988.4 4259.6 4295.0 4377.1 4428.3 4438.8 3058.9 3064.4 3074.2 3079.0 3088.7 563.3 583.0 586.7 590.2 593.9 550.0 627.7 631.6 680.7 685.3 8720.2 8936.7 9348.4 9653.8 9700.8 518.5 627.6 708.6 740.2 752.9 3753.6 4215.2 4241.7 4329.2 4411.3 53353.2 54321.7 54493.7 54832.2 55541.4 49064.8 49122.5 51207.7 52530.7 53548.2 43460.3 43471.8 44030.1 44481.8 44850.6 8764.0 8766.5 8976.2 9025.9 9368.3 34041.5 34317.3 34522.0 34989.7 35016.8 40156.0 41295.8 41707.0 41790.6 42866.6 10762.6 11040.7 11287.7 11512.5 11676.5 11567.8 11576.0 11751.4 12180.6 12639.7 11874.0 11901.2 12138.6 12376.4 12397.7 11436.1 11469.7 11534.6 11931.4 11946.5 11016.9 11356.0 11407.5 11612.0 11613.2 9203.0 9283.4 9470.8 9482.4 9578.1 9012.0 9067.3 9191.4 9853.5 9887.2 17:00:43 INFO - PROCESS | 5699 | -------- Summary: end -------- 17:00:43 INFO - PROCESS | 5699 | 17:00:44 INFO - TEST-INFO | 5699: exit 0 17:00:44 INFO - TEST-OK | dromaeo_css | took 1109851ms 17:00:44 INFO - TEST-START | kraken 17:00:44 INFO - operating with platform_type : linux_ 17:00:44 INFO - Initialising browser for kraken test... 17:00:44 INFO - TEST-INFO | started process 5939 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMsam8w/profile http://localhost:33220/getInfo.html) 17:00:47 INFO - PROCESS | 5939 | 17:00:47 INFO - PROCESS | 5939 | (process:6011): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:48 INFO - PROCESS | 5939 | __metrics Screen width/height:1600/1200 17:00:48 INFO - PROCESS | 5939 | colorDepth:24 17:00:48 INFO - PROCESS | 5939 | Browser inner width/height: 1024/697 17:00:48 INFO - PROCESS | 5939 | __metrics 17:00:48 INFO - PROCESS | 5939 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:00:49 INFO - TEST-INFO | 5939: exit 0 17:00:49 INFO - Browser initialized. 17:00:49 INFO - Running cycle 1/1 for kraken test... 17:00:49 INFO - TEST-INFO | started process 6060 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMsam8w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:50 INFO - PROCESS | 6060 | 17:00:50 INFO - PROCESS | 6060 | (process:6115): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:01 INFO - PROCESS | 6060 | RSS: Main: 150491136 17:01:01 INFO - PROCESS | 6060 | 17:01:03 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33220/tests/kraken/driver.html?testName=audio-beat-detection) 17:01:04 INFO - PROCESS | 6060 | RSS: Main: 154243072 17:01:04 INFO - PROCESS | 6060 | 17:01:07 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33220/tests/kraken/driver.html?testName=audio-dft) 17:01:07 INFO - PROCESS | 6060 | RSS: Main: 157028352 17:01:07 INFO - PROCESS | 6060 | 17:01:10 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33220/tests/kraken/driver.html?testName=audio-fft) 17:01:11 INFO - PROCESS | 6060 | RSS: Main: 152608768 17:01:11 INFO - PROCESS | 6060 | 17:01:13 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33220/tests/kraken/driver.html?testName=audio-oscillator) 17:01:13 INFO - PROCESS | 6060 | RSS: Main: 151433216 17:01:13 INFO - PROCESS | 6060 | 17:01:15 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:01:16 INFO - PROCESS | 6060 | RSS: Main: 151748608 17:01:16 INFO - PROCESS | 6060 | 17:01:19 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33220/tests/kraken/driver.html?testName=imaging-darkroom) 17:01:20 INFO - PROCESS | 6060 | RSS: Main: 152842240 17:01:20 INFO - PROCESS | 6060 | 17:01:23 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33220/tests/kraken/driver.html?testName=imaging-desaturate) 17:01:24 INFO - PROCESS | 6060 | RSS: Main: 153534464 17:01:24 INFO - PROCESS | 6060 | 17:01:26 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33220/tests/kraken/driver.html?testName=json-parse-financial) 17:01:27 INFO - PROCESS | 6060 | RSS: Main: 154046464 17:01:27 INFO - PROCESS | 6060 | 17:01:29 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:01:29 INFO - PROCESS | 6060 | RSS: Main: 154300416 17:01:29 INFO - PROCESS | 6060 | 17:01:31 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:01:32 INFO - PROCESS | 6060 | RSS: Main: 152379392 17:01:32 INFO - PROCESS | 6060 | 17:01:34 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:01:34 INFO - PROCESS | 6060 | RSS: Main: 152719360 17:01:34 INFO - PROCESS | 6060 | 17:01:37 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:01:37 INFO - PROCESS | 6060 | RSS: Main: 152502272 17:01:37 INFO - PROCESS | 6060 | 17:01:40 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:01:40 INFO - PROCESS | 6060 | RSS: Main: 152387584 17:01:40 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | Cycle 1(1): loaded http://localhost:33220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33220/tests/kraken/driver.html?testName=ai-astar) 17:01:42 INFO - PROCESS | 6060 | RSS: Main: 155422720 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | __start_tp_report 17:01:42 INFO - PROCESS | 6060 | _x_x_mozilla_page_load 17:01:42 INFO - PROCESS | 6060 | _x_x_mozilla_page_load_details 17:01:42 INFO - PROCESS | 6060 | |i|pagename|runs| 17:01:42 INFO - PROCESS | 6060 | |0;ai-astar;112;106;112;113;111;122;111;111;110;111 17:01:42 INFO - PROCESS | 6060 | |1;audio-beat-detection;148;126;157;165;128;152;155;130;165;128 17:01:42 INFO - PROCESS | 6060 | |2;audio-dft;163;161;161;162;162;159;162;165;170;159 17:01:42 INFO - PROCESS | 6060 | |3;audio-fft;73;74;73;73;73;125;76;73;73;73 17:01:42 INFO - PROCESS | 6060 | |4;audio-oscillator;95;96;148;97;96;96;141;95;96;144 17:01:42 INFO - PROCESS | 6060 | |5;imaging-gaussian-blur;109;110;110;111;110;110;111;110;110;110 17:01:42 INFO - PROCESS | 6060 | |6;imaging-darkroom;147;147;150;148;146;146;147;147;147;147 17:01:42 INFO - PROCESS | 6060 | |7;imaging-desaturate;96;96;98;96;98;98;97;97;96;96 17:01:42 INFO - PROCESS | 6060 | |8;json-parse-financial;60;60;59;59;60;62;60;60;67;56 17:01:42 INFO - PROCESS | 6060 | |9;json-stringify-tinderbox;68;69;72;68;75;69;70;68;71;69 17:01:42 INFO - PROCESS | 6060 | |10;stanford-crypto-aes;83;80;83;82;90;83;86;91;83;82 17:01:42 INFO - PROCESS | 6060 | |11;stanford-crypto-ccm;116;121;131;113;124;123;117;124;114;119 17:01:42 INFO - PROCESS | 6060 | |12;stanford-crypto-pbkdf2;142;141;140;138;150;140;140;140;141;140 17:01:42 INFO - PROCESS | 6060 | |13;stanford-crypto-sha256-iterative;66;75;66;67;67;64;66;67;73;67 17:01:42 INFO - PROCESS | 6060 | __end_tp_report 17:01:42 INFO - PROCESS | 6060 | __start_cc_report 17:01:42 INFO - PROCESS | 6060 | _x_x_mozilla_cycle_collect,758 17:01:42 INFO - PROCESS | 6060 | __end_cc_report 17:01:42 INFO - PROCESS | 6060 | __startTimestamp1453683702806__endTimestamp 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | ------- Summary: start ------- 17:01:42 INFO - PROCESS | 6060 | Number of tests: 14 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.01 (3.6%) stddev-sans-first:4.26 17:01:42 INFO - PROCESS | 6060 | Values: 112.0 106.0 112.0 113.0 111.0 122.0 111.0 111.0 110.0 111.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:153.50 stddev:15.86 (10.3%) stddev-sans-first:16.80 17:01:42 INFO - PROCESS | 6060 | Values: 148.0 126.0 157.0 165.0 128.0 152.0 155.0 130.0 165.0 128.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:3.20 (2.0%) stddev-sans-first:3.39 17:01:42 INFO - PROCESS | 6060 | Values: 163.0 161.0 161.0 162.0 162.0 159.0 162.0 165.0 170.0 159.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#3] audio-fft Cycles:10 Average:78.60 Median:73.00 stddev:16.33 (22.4%) stddev-sans-first:17.20 17:01:42 INFO - PROCESS | 6060 | Values: 73.0 74.0 73.0 73.0 73.0 125.0 76.0 73.0 73.0 73.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:23.48 (24.5%) stddev-sans-first:24.24 17:01:42 INFO - PROCESS | 6060 | Values: 95.0 96.0 148.0 97.0 96.0 96.0 141.0 95.0 96.0 144.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 17:01:42 INFO - PROCESS | 6060 | Values: 109.0 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 17:01:42 INFO - PROCESS | 6060 | Values: 147.0 147.0 150.0 148.0 146.0 146.0 147.0 147.0 147.0 147.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.93 17:01:42 INFO - PROCESS | 6060 | Values: 96.0 96.0 98.0 96.0 98.0 98.0 97.0 97.0 96.0 96.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:2.79 (4.7%) stddev-sans-first:2.96 17:01:42 INFO - PROCESS | 6060 | Values: 60.0 60.0 59.0 59.0 60.0 62.0 60.0 60.0 67.0 56.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.50 stddev:2.23 (3.2%) stddev-sans-first:2.26 17:01:42 INFO - PROCESS | 6060 | Values: 68.0 69.0 72.0 68.0 75.0 69.0 70.0 68.0 71.0 69.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.59 (4.3%) stddev-sans-first:3.78 17:01:42 INFO - PROCESS | 6060 | Values: 83.0 80.0 83.0 82.0 90.0 83.0 86.0 91.0 83.0 82.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.00 stddev:5.51 (4.5%) stddev-sans-first:5.63 17:01:42 INFO - PROCESS | 6060 | Values: 116.0 121.0 131.0 113.0 124.0 123.0 117.0 124.0 114.0 119.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:140.50 stddev:3.26 (2.3%) stddev-sans-first:3.44 17:01:42 INFO - PROCESS | 6060 | Values: 142.0 141.0 140.0 138.0 150.0 140.0 140.0 140.0 141.0 140.0 17:01:42 INFO - PROCESS | 6060 | 17:01:42 INFO - PROCESS | 6060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:3.43 (5.1%) stddev-sans-first:3.57 17:01:42 INFO - PROCESS | 6060 | Values: 66.0 75.0 66.0 67.0 67.0 64.0 66.0 67.0 73.0 67.0 17:01:42 INFO - PROCESS | 6060 | -------- Summary: end -------- 17:01:42 INFO - PROCESS | 6060 | 17:01:43 INFO - TEST-INFO | 6060: exit 0 17:01:43 INFO - TEST-OK | kraken | took 59164ms 17:01:43 INFO - TEST-START | v8_7 17:01:43 INFO - operating with platform_type : linux_ 17:01:43 INFO - Initialising browser for v8_7 test... 17:01:43 INFO - TEST-INFO | started process 6343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OKhLQ/profile http://localhost:33220/getInfo.html) 17:01:46 INFO - PROCESS | 6343 | 17:01:46 INFO - PROCESS | 6343 | (process:6418): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:47 INFO - PROCESS | 6343 | __metrics Screen width/height:1600/1200 17:01:47 INFO - PROCESS | 6343 | colorDepth:24 17:01:47 INFO - PROCESS | 6343 | Browser inner width/height: 1024/697 17:01:47 INFO - PROCESS | 6343 | __metrics 17:01:47 INFO - PROCESS | 6343 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:01:47 INFO - PROCESS | 6343 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:01:48 INFO - TEST-INFO | 6343: exit 0 17:01:48 INFO - Browser initialized. 17:01:48 INFO - Running cycle 1/1 for v8_7 test... 17:01:48 INFO - TEST-INFO | started process 6468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OKhLQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:50 INFO - PROCESS | 6468 | 17:01:50 INFO - PROCESS | 6468 | (process:6527): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:00 INFO - PROCESS | 6468 | RSS: Main: 152227840 17:02:00 INFO - PROCESS | 6468 | 17:02:22 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:33220/tests/v8_7/run.html (next: http://localhost:33220/tests/v8_7/run.html) 17:02:23 INFO - PROCESS | 6468 | RSS: Main: 151134208 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | __start_tp_report 17:02:23 INFO - PROCESS | 6468 | _x_x_mozilla_page_load 17:02:23 INFO - PROCESS | 6468 | _x_x_mozilla_page_load_details 17:02:23 INFO - PROCESS | 6468 | |i|pagename|runs| 17:02:23 INFO - PROCESS | 6468 | |0;Richards;167.1402306535183 17:02:23 INFO - PROCESS | 6468 | |1;DeltaBlue;188.64365214110546 17:02:23 INFO - PROCESS | 6468 | |2;Encrypt;279.87685418415896 17:02:23 INFO - PROCESS | 6468 | |3;Decrypt;5246.073298429319 17:02:23 INFO - PROCESS | 6468 | |4;RayTrace;1085.7763300760043 17:02:23 INFO - PROCESS | 6468 | |5;Earley;684.4626967830253 17:02:23 INFO - PROCESS | 6468 | |6;Boyer;12256.09756097561 17:02:23 INFO - PROCESS | 6468 | |7;RegExp;41770.833333333336 17:02:23 INFO - PROCESS | 6468 | |8;Splay;564.9717514124294 17:02:23 INFO - PROCESS | 6468 | |9;NavierStokes;4822.115384615385 17:02:23 INFO - PROCESS | 6468 | __end_tp_report 17:02:23 INFO - PROCESS | 6468 | __startTimestamp1453683743113__endTimestamp 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | ------- Summary: start ------- 17:02:23 INFO - PROCESS | 6468 | Number of tests: 10 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 167.1 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 188.6 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 279.9 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 5246.1 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 1085.8 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#5] Earley Cycles:1 Average:684.46 Median:684.46 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 684.5 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 12256.1 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#7] RegExp Cycles:1 Average:41770.83 Median:41770.83 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 41770.8 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#8] Splay Cycles:1 Average:564.97 Median:564.97 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 565.0 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - PROCESS | 6468 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 17:02:23 INFO - PROCESS | 6468 | Values: 4822.1 17:02:23 INFO - PROCESS | 6468 | -------- Summary: end -------- 17:02:23 INFO - PROCESS | 6468 | 17:02:23 INFO - TEST-INFO | 6468: exit 0 17:02:24 INFO - TEST-OK | v8_7 | took 40325ms 17:02:24 INFO - SUITE-END | took 1209s 17:02:24 INFO - Completed test suite (00:20:09) 17:02:24 INFO - Working with test: dromaeo_css 17:02:24 INFO - Generating results file: dromaeo_css 17:02:24 INFO - Working with test: kraken 17:02:24 INFO - Generating results file: kraken 17:02:24 INFO - javascript benchmark 17:02:24 INFO - Working with test: v8_7 17:02:24 INFO - Generating results file: v8_7 17:02:24 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:02:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 17:02:24 INFO - process_Request line: dromaeo_css 6937.25 graph.html#tests=[[72,1,43]] 17:02:24 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:02:24 INFO - process_Request line: kraken 1506.50 graph.html#tests=[[232,1,43]] 17:02:24 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:02:24 INFO - process_Request line: v8_7 20512.46 graph.html#tests=[[230,1,43]] 17:02:24 INFO - RETURN: dromaeo_css: 6937.25 17:02:24 INFO - RETURN: kraken: 1506.50 17:02:24 INFO - RETURN: v8_7: 20512.46 17:02:24 INFO - javascript benchmark 17:02:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3223.3553289342135, 3227.596550431196, 3262.200760813601, 3283.2940917702695, 3288.177955511122, 5204.739763011853, 5373.194020896867, 5393.757280922353, 5398.865028374293, 5419.1058475351565, 5334.653247538917, 5365.141577347626, 5371.623986320949, 5383.407825139231, 5392.245085688007, 4894.265860120992, 4898.926516102261, 4967.826126085588, 4998.2002879539095, 5002.974985125069, 772.449647005046, 4854.17479028566, 4880.292357608145, 4883.706977581339, 4922.729249891255, 4839.903201935959, 4849.369581954341, 4873.098476781789, 4897.7795999180125, 4898.363212782351, 4869.975650121727, 4885.56029957302, 4890.0953323634885, 4897.730624815634, 4947.134251505972, 4800.447948485899, 4878.536539028786, 4890.0953323634885, 4909.140900342426, 4942.530459606368, 5153.123968925292, 5218.739063046833, 5249.580033597303, 5254.08053590624, 5263.6578622389425, 5676.460736230051, 5696.430356964271, 5702.201691763156, 5719.542436605103, 5733.197352370671, 5682.971585142048, 5749.856253593652, 5771.797987070432, 5772.3361813391575, 5785.0, 5346.786128554853, 5392.137258038695, 5407.486288802557, 5407.621466497308, 5446.645968012067, 5861.384554621789, 5874.882502350015, 5879.176915231871, 5881.970655135334, 5882.617629854046, 5556.16657501378, 5586.944130558642, 5588.0, 5666.575006874501, 5673.432656734293, 5698.487136157766, 5811.912821307684, 5818.156367326714, 5837.854053648693, 5865.618734782225, 5654.547636189095, 5665.178549110356, 5712.800051998243, 5731.885362292731, 5737.053386191315, 5603.327600687943, 5697.686627235542, 5700.8859822803315, 5723.055695810228, 5740.827775166752, 4482.417285752831, 4487.394201782718, 4497.415336006298, 4519.796609152596, 4527.411436513232, 4014.6988975826343, 4022.6178513041214, 4029.6977726670616, 4034.3948407739076, 4046.0289530512464, 5241.868953276123, 5272.0, 5385.192221166856, 5387.865303367369, 5426.484483974016, 5747.597668163272, 5761.366249712528, 5788.5369170466265, 5800.854978625568, 5838.883222335529, 5361.0, 5369.677819330853, 5391.541718953855, 5395.62230643859, 5407.324084489439, 4804.471508134103, 4852.344933434012, 4908.435529914034, 4946.62900282473, 4978.327925730053, 5885.911711324334, 5957.4638282553915, 6003.309619393738, 6047.395260474005, 6055.303640081447, 5759.366469688414, 5766.163906233656, 5774.942250577608, 5782.45066718661, 5802.767889284381, 5865.354810970704, 6001.339852616296, 6008.279006519071, 6009.308929472992, 6014.308354539284, 5576.024195765806, 5631.521320687623, 5633.957717822216, 5641.943580564306, 5731.0, 5777.0, 5803.622764520293, 5814.534837212928, 5821.068629019336, 5874.206982057368, 5686.09022556389, 5686.914696279642, 5692.8576785579035, 5702.857428564153, 5704.429557044263, 5407.7025763581805, 5561.721913904369, 5577.051901176891, 5585.748641311232, 5696.743646535833, 5525.861853453695, 5536.169574563848, 5581.888362232814, 5602.943970560243, 5628.493435590816, 5652.180433837153, 5656.6888821115235, 5670.546356291569, 5693.601447898607, 5703.230063941315, 5365.195220716768, 5415.106507426231, 5463.53559947393, 5555.72221388937, 5588.189712491585], "unit": "score", "name": "dojo.html", "value": 5279.0698250721825}, {"lowerIsBetter": false, "replicates": [506.7947481270085, 516.4680379209414, 517.9922301165485, 527.9208118782183, 542.1840130603441, 35925.28149437013, 36211.456828147566, 36398.63601363986, 36439.271214575696, 36524.81737591315, 38685.0, 39129.0, 39531.604683953155, 39548.40677389834, 39579.802100989524, 8341.499510029387, 8518.957405212996, 8564.057953625097, 8606.612702428374, 8619.094995025525, 8294.917050829476, 8406.28546573542, 8417.915820841774, 8621.18098780618, 8654.48073115612, 8624.870626940601, 8659.393842431033, 8684.782880427976, 8691.435056721324, 8705.956470217672, 8562.529060901648, 8608.612612432456, 8611.181937715939, 8615.698450554262, 8670.52312122833, 8395.454295470774, 8469.280111190556, 8486.448380855225, 8488.53313067781, 8561.614727337284, 38959.0, 39570.80214598937, 39671.80164099161, 39781.0, 39781.40327895084, 2682.8256163349515, 3161.525771134325, 3169.524571314298, 3183.2996740717003, 3556.7332450066347, 26866.731332686813, 27380.0, 28306.575401368995, 29131.563026554617, 29955.850220748758, 3173.127389967777, 3179.984100079508, 3272.296456261915, 3296.159479332755, 3366.6801653842845, 209414.0, 209543.95228023914, 210640.0, 211118.0, 212083.0, 53744.0, 54467.45532544703, 60279.0, 63269.0, 64326.35673643297, 55318.17022744662, 55379.72310138504, 55429.1685624716, 55470.0, 55835.44164558302, 15763.842361576237, 15854.207289635473, 15953.202339882959, 15999.120048397217, 16000.359985600446, 11992.760144797056, 12020.879791202151, 12083.275003499819, 12121.575744848888, 12197.634070977885, 20353.0, 20421.0, 20492.0, 20519.8974005132, 20626.58746825055, 7495.138059123162, 7800.5709685966685, 7810.843783124419, 7817.726379576801, 7846.568438735924, 920.742192186189, 933.026648638139, 970.9708708738749, 1054.752133248686, 1074.984139987704, 29262.414751705273, 29332.706672932996, 29616.111516654535, 29821.85089074541, 30642.846785765927, 982.7150126463389, 1024.902634249745, 1030.1449796668746, 1060.6446840308583, 1073.7047311989108, 14024.825438338004, 14148.43406263738, 14327.78508322376, 14415.78376324356, 14474.855251447561, 382313.0, 389960.0, 390418.0, 391545.0, 392929.0, 53579.40883892282, 53682.73158634182, 53938.19092713612, 53945.73027134917, 54362.45637543653, 1323.3383308345826, 1333.0468714868916, 1334.2328161307094, 1336.8729970652773, 1353.5465619017739, 26937.86531067332, 27261.182164535097, 27569.862150689118, 27836.0, 28092.85953570219, 44230.0, 44497.55502445064, 44592.0, 44743.328850066624, 45009.77495112504, 291297.0, 292010.5399472989, 293290.0, 293726.0, 294356.0, 33263.66736332606, 43253.0, 43353.56646433495, 43977.0, 44376.2249510016, 39042.414363783995, 39449.40825887671, 40417.39373909335, 42831.0, 43599.56400435955, 36278.0, 36338.0, 37136.25727485489, 38482.42276365801, 39427.40858887062, 35418.8229058853, 36519.81740091283, 37397.81301093477, 37410.064748381505, 38316.61683383131, 33229.16927076843, 34064.0, 34097.48853767146, 38315.42526862155, 38801.417978730904, 28991.710082898902, 30861.38277234398, 33517.32965340728, 33621.0, 33722.0, 25167.49665006653, 25195.24414267575, 25202.747972520774, 25284.241472755846, 25552.744472555038], "unit": "score", "name": "ext.html", "value": 18246.011192053065}, {"lowerIsBetter": false, "replicates": [353.4027493535924, 358.19585031604043, 358.6216541548666, 359.2312451354101, 366.54914455220097, 11021.724456888582, 11533.365664888448, 15390.769138462932, 16049.438269660564, 16994.150292485374, 16749.748753768705, 16950.0, 17063.48809535716, 17177.57056073599, 17198.0, 5556.138798486231, 5927.496162826165, 5933.673647949361, 5948.672822994734, 5964.761409543635, 5719.914201286984, 5839.0, 5894.322152952401, 5953.493953013977, 5969.88060238795, 5924.1113832924975, 5937.317208521033, 5983.1025346197985, 6233.0, 6489.513286503531, 6375.872482550346, 6401.583897046677, 6417.518686098561, 6507.219133703986, 6715.992601109872, 6323.968380158116, 6483.351664833479, 6501.869962600722, 6506.54454188207, 6513.413792758627, 21064.5787084259, 21746.56506869854, 21759.67360489594, 21799.564008719735, 22193.334199974026, 2275.4615533144233, 2289.107248173197, 2341.613633750429, 2370.988145059281, 2456.5578195924727, 12663.936680316632, 13180.6704832379, 13488.39302231402, 13733.931330343385, 14002.0898641589, 1768.8408043276038, 1858.656148612511, 1921.4331772127116, 1956.7749708783388, 2013.114229738925, 51010.0, 52377.7381113092, 53172.73413632907, 53341.0, 53730.194047089324, 14423.639409014859, 14427.0, 14475.710485790225, 14853.777193342108, 15045.774313385307, 12751.48994040228, 13139.934300328629, 13179.53871614508, 23067.769322306896, 23237.18669846581, 7062.929370706227, 7351.0, 7643.388528917673, 7673.309402153833, 7678.692852285958, 7445.329920307198, 7470.626468676544, 7472.215417381205, 7490.475666703279, 7554.2823431773895, 4456.62118719906, 4466.307722303049, 4477.6417886569, 4486.484054333728, 4507.909841803145, 1818.7908390534992, 1819.8353054045422, 1851.3057603398724, 1868.9813101869079, 1891.3569386408412, 952.9904700953041, 967.3277072434731, 997.396575072071, 1033.6692258477215, 1050.873895132589, 15113.697726045417, 15424.228788560527, 15646.0, 15690.529284121494, 16337.673246535003, 885.2740752582949, 945.3618807305041, 949.6486300069018, 989.8564708117283, 1014.2747935226348, 8608.0, 8947.642094316285, 9254.213391861767, 9544.141027307576, 9633.0, 470139.0, 470618.4098033617, 472427.0, 484790.0, 490155.0, 67439.32560674429, 69437.0, 69792.65103674449, 70810.2918970814, 71031.0, 1130.4121856634667, 1134.9886501134883, 1164.7728692904802, 1185.8991985681141, 1189.6668932698858, 14255.857441425867, 14737.484188053366, 14930.701385972003, 15000.774988374966, 15013.474528391454, 29296.853515732284, 29915.102546923627, 30124.54813177848, 30429.239269018453, 30925.134358205225, 37524.249515010095, 37913.2149115828, 38274.80862595669, 42168.1566368677, 42836.14327713366, 7257.673404696696, 7375.373093286916, 7481.438892083007, 7536.660850261861, 7585.0, 9401.435913845191, 10740.30188037775, 10931.234813562975, 11124.499397526968, 11181.944090279496, 8075.838483230185, 8324.958375208085, 9472.100150485692, 9532.618695252113, 9583.808323833346, 8971.461712297283, 9116.954415228147, 9270.53647317618, 9397.859032114387, 9731.367461115005, 9523.23814094857, 9587.137157655565, 9729.951350243204, 9768.316217864682, 9947.0, 7582.317591416799, 7635.732749353746, 7724.343430808444, 7805.102413222325, 7808.453408261367, 8636.524991125549, 9856.655017074369, 9959.502024898582, 9998.25013124004, 10056.346337488332], "unit": "score", "name": "jquery.html", "value": 8493.475250842685}, {"lowerIsBetter": false, "replicates": [1432.376916041522, 1458.4822388052244, 1575.4958413307745, 1691.4840973503076, 1717.2615775216652, 7618.085829700437, 7659.923400766004, 7775.028121484815, 7792.337651299639, 7794.49335793173, 7800.141984381714, 7827.960860195691, 7841.372690184771, 7909.1299957004685, 7916.881246781303, 2109.0825490911425, 2137.177186783092, 2138.4440045588103, 2139.871607703543, 2143.8177754890776, 2127.8723276603378, 2146.957060858782, 2160.0603737374213, 2173.880436575988, 2184.071769497965, 2108.841836862234, 2124.9468763280966, 2133.797289257518, 2169.8481106322565, 2170.9565808683815, 2186.7157269554855, 2191.5726433345503, 2201.6147174244525, 2209.9668504972437, 2218.2125345502277, 2210.3700445372992, 2212.8451008429415, 2218.8557743746605, 2225.365770755327, 2236.7204099487562, 7813.570253636048, 7815.8436831263625, 7843.764687059397, 7871.409644276702, 7895.526268423855, 4678.812847486097, 4778.737169455679, 4812.302216178669, 4813.278008298748, 4817.662763606549, 2872.439874224527, 2958.1273524310163, 2971.806832555877, 2976.7618590512707, 2997.2357048952376, 938.5354249646468, 978.232087811072, 994.1847684898386, 1008.6822650865028, 1040.0483557544837, 10602.946985265102, 10645.84031239532, 10649.57401703931, 10651.307665001828, 10679.83980240297, 4037.212743515045, 4082.9183416331507, 4111.8560850370695, 4133.793310334471, 4145.79271036447, 8633.611487482953, 8777.297816174818, 8785.912140878638, 8803.251723603438, 8821.823563528822, 4555.863324100283, 4562.5665561771575, 4565.223911934979, 4575.9084818303445, 4591.9081618367445, 4171.749695018309, 4174.666026717855, 4196.265653510623, 4197.8320867165585, 4241.957580424218, 3220.822854742965, 3275.394052100369, 3346.832658367072, 3350.916227094342, 3358.3619112368574, 1049.2026060194307, 1050.1965996013057, 1053.1311667874033, 1074.2963358999868, 1075.8977897099762, 917.9082091790901, 975.3026585990908, 1122.6519778868576, 1177.1144278606964, 1335.8129861819352, 7279.927200727925, 7400.185979542353, 7436.73971410998, 7441.776746697607, 7474.887876681854, 631.0691729698749, 644.6100109433725, 645.2096182176796, 645.7287939065603, 777.7005852746734, 5626.465485778845, 5648.51987581052, 5758.62568933018, 5784.248047753765, 5797.855053623609, 9292.488913109844, 9546.284028697737, 9562.043795620382, 9585.424874507551, 9595.376300540582, 9046.959599645994, 9143.954280228689, 9148.222401095849, 9155.725328240163, 9316.114969077928, 7311.707531698778, 7388.076490438695, 7399.519031262951, 7406.148292946273, 7476.887846682304, 7259.165196002527, 7544.396448284015, 7602.277783610548, 7623.237676232332, 7632.274933881273, 8191.918080819116, 8337.416380853281, 8438.915610843813, 8556.871646925425, 8588.957055214683, 8465.28045116172, 8640.697575584825, 8681.869771953552, 8699.695510657097, 8747.16901894319, 6916.446684265347, 7492.100947886289, 7544.207858175032, 7588.734394296173, 7633.084029916446, 7181.820454488679, 7215.747448839265, 7218.133823941161, 7221.386182174364, 7221.638918054181, 6865.313468653295, 6876.346747059021, 6889.242183359726, 7036.155661320674, 7089.042979197742, 6521.5108866834225, 6631.469482441296, 6660.900086498803, 6708.228553716385, 6883.827904302432, 6635.767748128792, 6718.93281067183, 6749.0888730020815, 6891.965540172267, 6904.758333458305, 6389.7763578274535, 6550.803475895731, 6568.80293591193, 6653.334666533308, 6671.299513551201, 6501.8699626008165, 6570.6057636540045, 6573.244076931214, 6581.308962559054, 6599.8020059398295], "unit": "score", "name": "mootools.html", "value": 4360.964205627681}, {"lowerIsBetter": false, "replicates": [332.9794180835739, 340.884099406202, 344.6243594482014, 345.6508925984755, 346.52526039326125, 6214.658193799345, 6267.341929097436, 6308.0, 6334.271558770743, 6424.100625912376, 6206.286277078138, 6235.750569977206, 6254.781082662108, 6280.623162610235, 6281.623102613835, 4734.881627959311, 4735.3370528125915, 4742.976285118587, 4774.259989701602, 4775.832845850396, 4768.856934291976, 4769.189237829577, 4772.188727916246, 4787.688800227991, 4791.089692958344, 4623.797812568722, 4729.668923175379, 4729.692569982957, 4731.78706958186, 4753.144434001878, 4721.645876559254, 4724.858254252378, 4728.621710263171, 4731.290306454025, 4733.479317275097, 4093.6520395766397, 4095.1400205956784, 4098.180363927227, 4098.610631989956, 4108.239975604522, 5941.435563621449, 5964.463198312173, 5967.940320596826, 5991.970040149771, 5992.161097446361, 5407.864803379907, 5517.420670829545, 5519.862003449905, 5541.778328866841, 5546.77812887484, 6584.934150658528, 6630.303818099078, 6644.103046088764, 6660.600363978128, 6684.665766711693, 4516.277395616686, 4532.70537415067, 4539.750313732743, 4547.24970379887, 4561.40701708779, 6787.932120678779, 6871.622060786654, 6888.173419189679, 6891.37977582015, 6957.0, 4636.188666983265, 4640.373549570832, 4649.767511624405, 4659.324397962277, 4661.417322834645, 4707.552782485658, 4720.976395118002, 4722.9763851181215, 4727.267273572602, 4731.053789242165, 5478.726063696799, 5484.561235101182, 5485.0, 5495.560355171577, 5495.697736624444, 6570.638614876228, 6668.799936001928, 6709.6980635871505, 6776.69504872282, 6779.0, 1625.959351016234, 1636.4599682104877, 1661.6261341198376, 1667.6664667066393, 1669.8330166983205, 1093.573506332531, 1097.7091070866227, 1101.4547798839626, 1110.566878917223, 1118.3737107219983, 6113.5414843886, 6154.599951003171, 6161.507079433634, 6187.81436556895, 6193.535484838655, 6696.86153353931, 6743.696533655997, 6754.290799466084, 6762.932370676329, 6774.593524388552, 6054.152418661391, 6127.295361033449, 6166.5991710539565, 6179.258488981351, 6179.351168127282, 3649.7810131392202, 3656.634336566322, 3667.8716244931834, 3673.1551743099235, 3685.557733071995, 6916.20463646677, 6934.0, 6943.89584156238, 6959.408450281681, 6970.756023539253, 6754.6284954327, 6885.793426197222, 6903.033575299462, 6939.23668396476, 6956.0, 7030.402415794612, 7050.259722729143, 7062.258462861429, 7077.5753454792875, 7104.289571042855, 6720.596764193969, 6730.0241464988285, 6748.831279218059, 6758.493113016445, 6782.253952065367, 6590.538662293593, 6642.535022548568, 6706.865862682622, 6718.596884186964, 6727.562708423937, 6988.650567471708, 7066.328698773608, 7080.079589653312, 7080.398166155728, 7083.787486375417, 4601.44782626087, 4629.629629629689, 4634.351190833353, 4653.929596192962, 4663.650226232979, 6695.899561506484, 6707.731690732316, 6739.359760822714, 6774.390304872585, 6952.5480843745, 6710.932890671031, 6756.898646520404, 6767.593944363354, 6768.593884366954, 6775.966120169368, 6676.198856137295, 6678.866422671422, 6679.298673639392, 6716.126903502513, 6717.093192418961, 6440.098386225838, 6507.609543427409, 6573.57271777333, 6590.7693230736695, 6608.339166083353, 6768.120144381199, 6768.424683901727, 6770.052192693125, 6775.830604234737, 6783.694733737092, 6536.411722944958, 6583.539152259296, 6600.0099985002635, 6605.0, 6605.438537724347], "unit": "score", "name": "prototype.html", "value": 4970.6154728518195}, {"lowerIsBetter": false, "replicates": [696.2480521037279, 741.3031750154857, 779.8128449172196, 800.4476910931459, 825.5872063968015, 12472.2516649001, 12540.184887982276, 12552.0, 12575.748485030304, 12654.240745555273, 12539.435725392357, 12553.623391298253, 12563.434645440955, 12585.307808070553, 12609.810852837192, 777.3470284960632, 789.4118881433326, 794.5232860283842, 795.6340083561569, 795.6817273090752, 810.2059981218409, 813.4631143445328, 813.6907974969504, 814.7474282972297, 818.0428898189103, 830.2859540794911, 832.3923535818856, 834.7829564313262, 835.1231207232412, 836.6109758962082, 819.1849110135454, 823.9464434811748, 830.0620299062022, 830.4685001598981, 832.1636755061155, 608.9908651370233, 612.7793994162098, 612.788587937161, 615.2524682510771, 617.7065893700457, 13833.861661383458, 13940.16359018452, 13954.372053257526, 13980.0, 13985.72028559423, 12470.314132722697, 12532.436040378205, 12600.369981500888, 12928.612141635766, 12976.91227263409, 10034.69895903124, 10316.277860549764, 10328.380297182193, 10841.83737243942, 10852.891471085268, 3567.9108022299392, 3598.0, 3659.780413175218, 3733.4959780429567, 3786.8106594670157, 47012.764936175445, 47467.52532474665, 47672.76163619194, 47748.761256193495, 47845.97617250208, 9521.19069879068, 9656.179224765832, 9708.660196893075, 9750.366226195416, 9845.50772461374, 16345.591360216089, 16402.753958690628, 17357.392491263, 17622.118894055246, 17647.823521764876, 7658.617069146632, 7715.498492597963, 7760.146383897767, 7899.960500197577, 7988.400869934778, 4259.637930775857, 4294.954721862835, 4377.124575084996, 4428.31361139024, 4438.844640437569, 3058.877644894224, 3064.417760625474, 3074.216074900886, 3078.9692103078683, 3088.722015018659, 563.3240111865778, 583.0467186150674, 586.6597373523347, 590.2268028882178, 593.9316978547436, 549.9972500137474, 627.7269387816223, 631.5579094633774, 680.6834821807884, 685.3044160177424, 8720.215180633773, 8936.68721594754, 9348.364036293622, 9653.758656033655, 9700.75748106303, 518.4737491446185, 627.6391075131818, 708.5536112249353, 740.1636151149274, 752.8720117580025, 3753.6058713834655, 4215.220184265921, 4241.703080784378, 4329.199098166786, 4411.338299255073, 53353.1997020045, 54321.72839135779, 54493.72753136209, 54832.17751733727, 55541.44458555443, 49064.75467622639, 49122.50877491251, 51207.74396127996, 52530.73734631302, 53548.196777048375, 43460.348094779234, 43471.78264108659, 44030.11939761187, 44481.777591112485, 44850.55149448529, 8764.0, 8766.474011559327, 8976.192142707188, 9025.909740902507, 9368.297377696565, 34041.48937765985, 34317.31365372628, 34522.0, 34989.650103498636, 35016.82491587526, 40156.0, 41295.7935210322, 41707.0, 41790.58209417989, 42866.57133428626, 10762.623308184176, 11040.668779936615, 11287.661370158909, 11512.481938312963, 11676.474558644712, 11567.768644626893, 11576.0, 11751.353675547927, 12180.605897883497, 12639.684007899508, 11874.0, 11901.166918315635, 12138.635840924786, 12376.381180941096, 12397.690057748629, 11436.085113191091, 11469.713257168303, 11534.59628912984, 11931.403429828648, 11946.522139114339, 11016.889831101907, 11356.034737047443, 11407.543698251977, 11612.010295677192, 11613.245139066272, 9203.0, 9283.39657922233, 9470.810583788149, 9482.353646713198, 9578.13796758295, 9012.0, 9067.319951003568, 9191.356605037583, 9853.507324633596, 9887.209023278265], "unit": "score", "name": "yui.html", "value": 6284.669316632157}], "name": "dromaeo_css", "value": 6937.248539086713}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 113.0, 111.0, 122.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [148.0, 126.0, 157.0, 165.0, 128.0, 152.0, 155.0, 130.0, 165.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 162.0, 159.0, 162.0, 165.0, 170.0, 159.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 73.0, 73.0, 125.0, 76.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 148.0, 97.0, 96.0, 96.0, 141.0, 95.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 150.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 98.0, 96.0, 98.0, 98.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 62.0, 60.0, 60.0, 67.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 72.0, 68.0, 75.0, 69.0, 70.0, 68.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 83.0, 82.0, 90.0, 83.0, 86.0, 91.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 131.0, 113.0, 124.0, 123.0, 117.0, 124.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 140.0, 138.0, 150.0, 140.0, 140.0, 140.0, 141.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [66.0, 75.0, 66.0, 67.0, 67.0, 64.0, 66.0, 67.0, 73.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1506.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [684.4626967830253], "unit": "score", "name": "Earley", "value": 973.7024430000004}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [41770.833333333336], "unit": "score", "name": "RegExp", "value": 21.809117206982535}, {"lowerIsBetter": false, "replicates": [564.9717514124294], "unit": "score", "name": "Splay", "value": 144.23906999999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20512.46123006896}]} 17:02:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20512.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1506.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6937.25"}}} 17:02:24 INFO - Return code: 0 17:02:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:02:24 INFO - # TBPL SUCCESS # 17:02:24 INFO - Running post-action listener: _resource_record_post_action 17:02:24 INFO - Running post-run listener: _resource_record_post_run 17:02:25 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 24576; Write bytes: 550055936; Read time: 348; Write time: 429124 17:02:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236302336; Read time: 0; Write time: 200584 17:02:25 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 313753600; Read time: 348; Write time: 228540 17:02:25 INFO - Running post-run listener: _upload_blobber_files 17:02:25 INFO - Blob upload gear active. 17:02:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:02:25 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:02:26 INFO - (blobuploader) - INFO - Open directory for files ... 17:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:27 INFO - (blobuploader) - INFO - Done attempting. 17:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:28 INFO - (blobuploader) - INFO - Done attempting. 17:02:28 INFO - (blobuploader) - INFO - Iteration through files over. 17:02:28 INFO - Return code: 0 17:02:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:02:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:02:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a96da5e7ce3f9ce1fa3d38b8d13d333fcb73f8099e75a0586ef4e307b5c32f6557d2313bb11fb5393d3f2cbd5e0e1bd72a4dbcb5588db53150f1b33f3bb49b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d36e9ab8c6a898af4534ecdcdbe89926ada20965e7584c1c6baa5812493e8317ae922184c4464b99a93b7e897b2e723bbaadcb2b7014c4f7f42a97420c1c27"} 17:02:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:02:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:02:28 INFO - Contents: 17:02:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a96da5e7ce3f9ce1fa3d38b8d13d333fcb73f8099e75a0586ef4e307b5c32f6557d2313bb11fb5393d3f2cbd5e0e1bd72a4dbcb5588db53150f1b33f3bb49b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d36e9ab8c6a898af4534ecdcdbe89926ada20965e7584c1c6baa5812493e8317ae922184c4464b99a93b7e897b2e723bbaadcb2b7014c4f7f42a97420c1c27"} 17:02:28 INFO - Running post-run listener: copy_logs_to_upload_dir 17:02:28 INFO - Copying logs to upload dir... 17:02:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:02:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.307503 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-24 17:02:28.035580) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:02:28.039484) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a96da5e7ce3f9ce1fa3d38b8d13d333fcb73f8099e75a0586ef4e307b5c32f6557d2313bb11fb5393d3f2cbd5e0e1bd72a4dbcb5588db53150f1b33f3bb49b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d36e9ab8c6a898af4534ecdcdbe89926ada20965e7584c1c6baa5812493e8317ae922184c4464b99a93b7e897b2e723bbaadcb2b7014c4f7f42a97420c1c27"} build_url:https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/W-xUeHk_RrW-C17gyEWQVw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a96da5e7ce3f9ce1fa3d38b8d13d333fcb73f8099e75a0586ef4e307b5c32f6557d2313bb11fb5393d3f2cbd5e0e1bd72a4dbcb5588db53150f1b33f3bb49b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8d36e9ab8c6a898af4534ecdcdbe89926ada20965e7584c1c6baa5812493e8317ae922184c4464b99a93b7e897b2e723bbaadcb2b7014c4f7f42a97420c1c27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 17:02:28.065024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:02:28.065402) ========= 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=0274524eba3bdaad075c2247000001d4-1453680076.24647-82417643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 17:02:28.147399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:02:28.147792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 17:02:28.148192) ========= ========= Total master_lag: 0.29 =========